wiki:neb-touch-gory-details

Context Navigation

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

Nebulous Gory Details

Nebulous Gory Details
1. neb-touch

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

Key.pm was modified to have log messages/Key.pm and Nebulous.pm log level both set to $DEBUG
Tests were performed on ippc01 with NEB_SERVER set to http://ippc01.ifa.hawaii.edu:80/nebulous as ipp user

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

More over since looking for the complete string is costly, it would be interesting to DESIGN the tables in the database so that search can be efficient (hash partitioning on ext_id?)

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.

Download in other formats:

Plain Text