IPP Software Navigation Tools IPP Links Communication Pan-STARRS Links
wiki:neb-touch-gory-details

Version 26 (modified by Serge CHASTEL, 15 years ago) ( diff )

--

Nebulous Gory Details

neb-touch

neb-touch has a call to two nebulous "primitive" functions: neb_stat and neb_create

Command / Context

neb-touch this/is/a/test/never/done/before

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

(Another experiment with neb-touch neb://ippc01.0/that/command/has/never/been/run give 23 calls to _stringify_key and 5 to _db_index_for_key for create_object -- stat_object is unchanged)

SQL statements decomposition: Stat_object statement

        SELECT
            so.so_id,
            so.ext_id,
            attr.read_lock,
            attr.write_lock,
            attr.epoch,
            attr.mtime,
            SUM(available) as available,
            COUNT(instance.so_id) as instances
        FROM storage_object as so
        JOIN storage_object_attr as attr
            USING (so_id)
        JOIN instance
            USING (so_id)
        LEFT JOIN mountedvol
            USING(vol_id)
        WHERE ext_id = ?
        GROUP BY so.so_id

with ? = this/is/a/test/never/done/before

Comment: Could be simplified since the only information which is used is (at the neb-touch script level): is there something called like that?! No need for so many joins!

Suggestion: Test with

SELECT ext_id FROM storage_object WHERE ext_id = ? LIMIT 1

SQL statements decomposition: Create_object statements

  • Statement 1:
            INSERT INTO storage_object
            (so_id, ext_id, ext_id_basename, type, dir_id)
            VALUES (?, ?, ?, 'REG_FILE', ?)
    

with ? = ('NULL', 'this/is/a/test/never/done/before', 'before', 12257)

Comment: Insterting 'NULL' while the value is auto-incremented leads to a warning.

  • Statement 2:
        SELECT LAST_INSERT_ID()

Comment: Sets the so_id value (to 804337).

  • Statement 3
        INSERT INTO storage_object_attr
        (so_id, read_lock, write_lock)
        VALUES (?, 0, NULL)

with ? = 804337

Comment: Replace so_id by LAST_INSERT_ID()?

  • Statement 4
        INSERT INTO instance 
        (so_id, vol_id, uri)
        VALUES (LAST_INSERT_ID(), ?, 'error')

with ? = 1

Comment: See below

  • Statement 5
        SELECT LAST_INSERT_ID()

Comment: Set the ins_id value

  • Statement 6
        UPDATE instance
        SET vol_id = ?, uri = ?
        WHERE ins_id = ?

where ? = (1, 'file:///export/ippc01.0/nebulous/96/9a/584332.this:is:a:test:never:done:before', 584332)

Comment: Between SQL statements 4 and 6, the _create_empty_instance_file function is called. Its purpose is to create a file and generate its URI, that is something like file:///export/ippc01.0/nebulous/a9/56/584333.that:command:has:never:been:run No SQL statement is performed between them. Statements 4 to 6 could be replaced by a single one:

        INSERT INTO instance 
        (so_id, vol_id, uri)
        VALUES (LAST_INSERT_ID(), ?, ?)

where ? = (1, 'file:///export/ippc01.0/nebulous/96/9a/584332.this:is:a:test:never:done:before')

Full 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

Note: See TracWiki for help on using the wiki.