= Nebulous Gory Details =

[[PageOutline]]
== neb-touch ==
  === Command / Context === 
  neb-touch this/is/a/test/never/done/before
 (Key.pm was modified to have log messages/Key.pm and Nebulous.pm log level both set to $DEBUG/Test performed on ippc01)

  === Trace Analysis ===
  (see next section for full trace)

 * Two SOAP messages: stat_object and create_object.
   It was expected.
 * stat_object analysis:
   * 4 calls to _stringify_key with the same arguments
 * create_object analysis:
   * 16 calls to _stringify_key with the same arguments
   * 4 calls to Nebulous::Server::_db_index_for_key with the same arguments

Note: Other experiment
neb-touch neb://ippc01.0/that/command/has/never/been/run
  === Trace ===
{{{
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::SOAP::AUTOLOAD - ################################
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::SOAP::AUTOLOAD - SOAP [stat_object]
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::SOAP::AUTOLOAD -   Arguments count: 1
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::SOAP::AUTOLOAD -     Argument [this/is/a/test/never/done/before]
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::SOAP::AUTOLOAD - ################################
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::stat_object - entered - this/is/a/test/never/done/before
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::_is_valid_object_key - entered - this/is/a/test/never/done/before
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::parse_neb_key - entered - parse_neb_key
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::parse_neb_key -   parse_neb_key Argument 1/key: this/is/a/test/never/done/before
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::parse_neb_key -   parse_neb_key Argument 2/volume: undefined
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::parse_neb_volume - entered - parse_neb_volume
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::parse_neb_key - leaving - parse_neb_key
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - entered - _stringify_key
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - _stringify_key: arg1this/is/a/test/never/done/before
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - _stringify_key: arg2
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - _stringify_key: arg3
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - leaving - _stringify_key
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::_is_valid_object_key - key neb:///this/is/a/test/never/done/before not found in cache
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - entered - _stringify_key
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - _stringify_key: arg1this/is/a/test/never/done/before
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - _stringify_key: arg2
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - _stringify_key: arg3
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - leaving - _stringify_key
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::db - entered - neb:///this/is/a/test/never/done/before
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - entered - _stringify_key
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - _stringify_key: arg1this/is/a/test/never/done/before
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - _stringify_key: arg2
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - _stringify_key: arg3
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - leaving - _stringify_key
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - entered - _stringify_key
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - _stringify_key: arg1this/is/a/test/never/done/before
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - _stringify_key: arg2
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - _stringify_key: arg3
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - leaving - _stringify_key
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::_db_index_for_key - entered - neb:///this/is/a/test/never/done/before
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::_db_index_for_key - index is 0
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::_db_index_for_key - leaving
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::_db_for_index - entered - 0
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::_db_for_index - db handle is still alive
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::_is_valid_object_key - key not found in db
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::_is_valid_object_key - leaving
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::SOAP::AUTOLOAD - ################################
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::SOAP::AUTOLOAD - SOAP [create_object]
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::SOAP::AUTOLOAD -   Arguments count: 2
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::SOAP::AUTOLOAD -     Argument [this/is/a/test/never/done/before]
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::SOAP::AUTOLOAD -     Argument udnfiend
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::SOAP::AUTOLOAD - ################################
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::create_object - entered - this/is/a/test/never/done/before 
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::parse_neb_key - entered - parse_neb_key
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::parse_neb_key -   parse_neb_key Argument 1/key: this/is/a/test/never/done/before
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::parse_neb_key -   parse_neb_key Argument 2/volume: undefined
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::parse_neb_volume - entered - parse_neb_volume
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::parse_neb_key - leaving - parse_neb_key
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - entered - _stringify_key
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - _stringify_key: arg1this/is/a/test/never/done/before
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - _stringify_key: arg2
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - _stringify_key: arg3
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - leaving - _stringify_key
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::db - entered - neb:///this/is/a/test/never/done/before
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - entered - _stringify_key
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - _stringify_key: arg1this/is/a/test/never/done/before
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - _stringify_key: arg2
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - _stringify_key: arg3
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - leaving - _stringify_key
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - entered - _stringify_key
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - _stringify_key: arg1this/is/a/test/never/done/before
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - _stringify_key: arg2
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - _stringify_key: arg3
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - leaving - _stringify_key
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::_db_index_for_key - entered - neb:///this/is/a/test/never/done/before
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::_db_index_for_key - index is 0
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::_db_index_for_key - leaving
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::_db_for_index - entered - 0
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::_db_for_index - db handle is still alive
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - entered - _stringify_key
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - _stringify_key: arg1this/is/a/test/never/done/before
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - _stringify_key: arg2
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - _stringify_key: arg3
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - leaving - _stringify_key
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::_get_storage_volume - entered - neb:///this/is/a/test/never/done/before  
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - entered - _stringify_key
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - _stringify_key: arg1this/is/a/test/never/done/before
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - _stringify_key: arg2
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - _stringify_key: arg3
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - leaving - _stringify_key
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::db - entered - neb:///this/is/a/test/never/done/before
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - entered - _stringify_key
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - _stringify_key: arg1this/is/a/test/never/done/before
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - _stringify_key: arg2
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - _stringify_key: arg3
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - leaving - _stringify_key
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - entered - _stringify_key
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - _stringify_key: arg1this/is/a/test/never/done/before
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - _stringify_key: arg2
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - _stringify_key: arg3
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - leaving - _stringify_key
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::_db_index_for_key - entered - neb:///this/is/a/test/never/done/before
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::_db_index_for_key - index is 0
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::_db_index_for_key - leaving
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::_db_for_index - entered - 0
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::_db_for_index - db handle is still alive
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::_get_storage_volume - leaving
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - entered - _stringify_key
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - _stringify_key: arg1this/is/a/test/never/done/before
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - _stringify_key: arg2
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - _stringify_key: arg3
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - leaving - _stringify_key
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::_resolve_dir_parent_id - entered - key neb:///this/is/a/test/never/done/before create 1
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - entered - _stringify_key
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - _stringify_key: arg1this/is/a/test/never/done/before
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - _stringify_key: arg2
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - _stringify_key: arg3
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - leaving - _stringify_key
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - entered - _stringify_key
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - _stringify_key: arg1this/is/a/test/never/done/before
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - _stringify_key: arg2
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - _stringify_key: arg3
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - leaving - _stringify_key
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::db - entered - neb:///this/is/a/test/never/done/before
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - entered - _stringify_key
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - _stringify_key: arg1this/is/a/test/never/done/before
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - _stringify_key: arg2
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - _stringify_key: arg3
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - leaving - _stringify_key
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - entered - _stringify_key
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - _stringify_key: arg1this/is/a/test/never/done/before
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - _stringify_key: arg2
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - _stringify_key: arg3
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - leaving - _stringify_key
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::_db_index_for_key - entered - neb:///this/is/a/test/never/done/before
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::_db_index_for_key - index is 0
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::_db_index_for_key - leaving
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::_db_for_index - entered - 0
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::_db_for_index - db handle is still alive
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::_resolve_dir_parent_id - looking for dirs - this : is : a : test : never : done
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::_resolve_dir_parent_id - resolved this to dir_id: 2
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::_resolve_dir_parent_id - resolved is to dir_id: 3
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::_resolve_dir_parent_id - resolved a to dir_id: 4
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::_resolve_dir_parent_id - resolved test to dir_id: 12249
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::_resolve_dir_parent_id - leaving
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::create_object - TRANS block
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::create_object - Eval 1:
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::create_object - 
        INSERT INTO storage_object
        (so_id, ext_id, ext_id_basename, type, dir_id)
        VALUES (?, ?, ?, 'REG_FILE', ?)
    
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::create_object - this/is/a/test/never/done/before
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::create_object - before
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::create_object - 12257
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::create_object - Eval 2:
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::create_object - 
        SELECT LAST_INSERT_ID()
    
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::create_object - Eval 3:
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::create_object - 
        INSERT INTO storage_object_attr
        (so_id, read_lock, write_lock)
        VALUES (?, 0, NULL)
    
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::create_object - 804337
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::create_object - Eval 4:
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::create_object - 
        INSERT INTO instance 
        (so_id, vol_id, uri)
        VALUES (LAST_INSERT_ID(), ?, 'error')
    
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::create_object - 1
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::create_object - Eval 5:
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::create_object - 
        SELECT LAST_INSERT_ID()
    
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - entered - _stringify_key
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - _stringify_key: arg1this/is/a/test/never/done/before
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - _stringify_key: arg2
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - _stringify_key: arg3
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - leaving - _stringify_key
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::_create_empty_instance_file - entered - neb:///this/is/a/test/never/done/before 804337 584332 /export/ippc01.0/nebulous 0
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - entered - _stringify_key
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - _stringify_key: arg1this/is/a/test/never/done/before
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - _stringify_key: arg2
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - _stringify_key: arg3
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - leaving - _stringify_key
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::db - entered - neb:///this/is/a/test/never/done/before
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - entered - _stringify_key
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - _stringify_key: arg1this/is/a/test/never/done/before
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - _stringify_key: arg2
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - _stringify_key: arg3
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - leaving - _stringify_key
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - entered - _stringify_key
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - _stringify_key: arg1this/is/a/test/never/done/before
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - _stringify_key: arg2
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - _stringify_key: arg3
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Key::_stringify_key - leaving - _stringify_key
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::_db_index_for_key - entered - neb:///this/is/a/test/never/done/before
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::_db_index_for_key - index is 0
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::_db_index_for_key - leaving
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::_db_for_index - entered - 0
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::_db_for_index - db handle is still alive
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::_retry - entered - CODE(0x14ffa20)
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::_create_empty_instance_file - generated uri file:///export/ippc01.0/nebulous/96/9a/584332.this:is:a:test:never:done:before
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::_create_empty_file - entered - /export/ippc01.0/nebulous/96/9a/584332.this:is:a:test:never:done:before
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::_retry - entered - CODE(0x1b8cc30)
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::_retry - entered - CODE(0x1b8cc30)
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::_retry - entered - CODE(0x1b8cc30)
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::_retry - entered - CODE(0x1b8cc30)
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::create_object - created file:///export/ippc01.0/nebulous/96/9a/584332.this:is:a:test:never:done:before on volume ID: 1
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::create_object - Eval 6
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::create_object - 
        UPDATE instance
        SET vol_id = ?, uri = ?
        WHERE ins_id = ?
    
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::create_object - 1
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::create_object - file:///export/ippc01.0/nebulous/96/9a/584332.this:is:a:test:never:done:before
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::create_object - 584332
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::create_object - commit
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::create_object - key added to cache
2011-02-09 16:11:49 | ippc01 | DEBUG | Nebulous::Server::create_object - leaving

}}}