Quiet mode disabled
[0.000000000000:ASSIGN] Assign cpal_system new value: Scheduling_Policy.FIFO
[0.000000000000:tut-introspection:STARTING_TASK] 'p1'
[0.000000000000:STATE] process "A_Process", instance "p1", state "Main"
[0.000000000000:PRINTLN] pid 0
[0.000000000000:PRINTLN] period 100ms
[0.000000000000:PRINTLN] offset 0
[0.000000000000:PRINTLN] curr 0
[0.000000000000:PRINTLN] last 0
[0.000000000000:tut-introspection:TASK_FINISHED] 'p1'
[0.100000000000:tut-introspection:STARTING_TASK] 'p1'
[0.100000000000:PRINTLN] pid 0
[0.100000000000:PRINTLN] period 100ms
[0.100000000000:PRINTLN] offset 0
[0.100000000000:PRINTLN] curr 100ms
[0.100000000000:PRINTLN] last 0
[0.100000000000:tut-introspection:TASK_FINISHED] 'p1'
[0.200000000000:tut-introspection:STARTING_TASK] 'p1'
[0.200000000000:PRINTLN] pid 0
[0.200000000000:PRINTLN] period 100ms
[0.200000000000:PRINTLN] offset 0
[0.200000000000:PRINTLN] curr 200ms
[0.200000000000:PRINTLN] last 100ms
[0.200000000000:tut-introspection:TASK_FINISHED] 'p1'
[0.300000000000:tut-introspection:STARTING_TASK] 'p1'
[0.300000000000:PRINTLN] pid 0
[0.300000000000:PRINTLN] period 100ms
[0.300000000000:PRINTLN] offset 0
[0.300000000000:PRINTLN] curr 300ms
[0.300000000000:PRINTLN] last 200ms
[0.300000000000:tut-introspection:TASK_FINISHED] 'p1'
[0.400000000000:tut-introspection:STARTING_TASK] 'p1'
[0.400000000000:PRINTLN] pid 0
[0.400000000000:PRINTLN] period 100ms
[0.400000000000:PRINTLN] offset 0
[0.400000000000:PRINTLN] curr 400ms
[0.400000000000:PRINTLN] last 300ms
[0.400000000000:tut-introspection:TASK_FINISHED] 'p1'
[0.500000000000:tut-introspection:STARTING_TASK] 'p1'
[0.500000000000:PRINTLN] pid 0
[0.500000000000:PRINTLN] period 100ms
[0.500000000000:PRINTLN] offset 0
[0.500000000000:PRINTLN] curr 500ms
[0.500000000000:PRINTLN] last 400ms
[0.500000000000:tut-introspection:TASK_FINISHED] 'p1'
[0.600000000000:tut-introspection:STARTING_TASK] 'p1'
[0.600000000000:PRINTLN] pid 0
[0.600000000000:PRINTLN] period 100ms
[0.600000000000:PRINTLN] offset 0
[0.600000000000:PRINTLN] curr 600ms
[0.600000000000:PRINTLN] last 500ms
[0.600000000000:tut-introspection:TASK_FINISHED] 'p1'
[0.700000000000:tut-introspection:STARTING_TASK] 'p1'
[0.700000000000:PRINTLN] pid 0
[0.700000000000:PRINTLN] period 100ms
[0.700000000000:PRINTLN] offset 0
[0.700000000000:PRINTLN] curr 700ms
[0.700000000000:PRINTLN] last 600ms
[0.700000000000:tut-introspection:TASK_FINISHED] 'p1'
[0.800000000000:tut-introspection:STARTING_TASK] 'p1'
[0.800000000000:PRINTLN] pid 0
[0.800000000000:PRINTLN] period 100ms
[0.800000000000:PRINTLN] offset 0
[0.800000000000:PRINTLN] curr 800ms
[0.800000000000:PRINTLN] last 700ms
[0.800000000000:tut-introspection:TASK_FINISHED] 'p1'
[0.900000000000:tut-introspection:STARTING_TASK] 'p1'
[0.900000000000:PRINTLN] pid 0
[0.900000000000:PRINTLN] period 100ms
[0.900000000000:PRINTLN] offset 0
[0.900000000000:PRINTLN] curr 900ms
[0.900000000000:PRINTLN] last 800ms
[0.900000000000:tut-introspection:TASK_FINISHED] 'p1'
[1.000000000000:tut-introspection:STARTING_TASK] 'p1'
[1.000000000000:PRINTLN] pid 0
[1.000000000000:PRINTLN] period 100ms
[1.000000000000:PRINTLN] offset 0
[1.000000000000:PRINTLN] curr 1s
[1.000000000000:PRINTLN] last 900ms
[1.000000000000:tut-introspection:TASK_FINISHED] 'p1'
[1.100000000000:tut-introspection:STARTING_TASK] 'p1'
[1.100000000000:PRINTLN] pid 0
[1.100000000000:PRINTLN] period 100ms
[1.100000000000:PRINTLN] offset 0
[1.100000000000:PRINTLN] curr 1s100ms
[1.100000000000:PRINTLN] last 1s
[1.100000000000:tut-introspection:TASK_FINISHED] 'p1'
[1.200000000000:tut-introspection:STARTING_TASK] 'p1'
[1.200000000000:PRINTLN] pid 0
[1.200000000000:PRINTLN] period 100ms
[1.200000000000:PRINTLN] offset 0
[1.200000000000:PRINTLN] curr 1s200ms
[1.200000000000:PRINTLN] last 1s100ms
[1.200000000000:tut-introspection:TASK_FINISHED] 'p1'
[1.300000000000:tut-introspection:STARTING_TASK] 'p1'
[1.300000000000:PRINTLN] pid 0
[1.300000000000:PRINTLN] period 100ms
[1.300000000000:PRINTLN] offset 0
[1.300000000000:PRINTLN] curr 1s300ms
[1.300000000000:PRINTLN] last 1s200ms
[1.300000000000:tut-introspection:TASK_FINISHED] 'p1'
[1.400000000000:tut-introspection:STARTING_TASK] 'p1'
[1.400000000000:PRINTLN] pid 0
[1.400000000000:PRINTLN] period 100ms
[1.400000000000:PRINTLN] offset 0
[1.400000000000:PRINTLN] curr 1s400ms
[1.400000000000:PRINTLN] last 1s300ms
[1.400000000000:tut-introspection:TASK_FINISHED] 'p1'
[1.500000000000:tut-introspection:STARTING_TASK] 'p1'
[1.500000000000:PRINTLN] pid 0
[1.500000000000:PRINTLN] period 100ms
[1.500000000000:PRINTLN] offset 0
[1.500000000000:PRINTLN] curr 1s500ms
[1.500000000000:PRINTLN] last 1s400ms
[1.500000000000:tut-introspection:TASK_FINISHED] 'p1'
[1.600000000000:tut-introspection:STARTING_TASK] 'p1'
[1.600000000000:PRINTLN] pid 0
[1.600000000000:PRINTLN] period 100ms
[1.600000000000:PRINTLN] offset 0
[1.600000000000:PRINTLN] curr 1s600ms
[1.600000000000:PRINTLN] last 1s500ms
[1.600000000000:tut-introspection:TASK_FINISHED] 'p1'
[1.700000000000:tut-introspection:STARTING_TASK] 'p1'
[1.700000000000:PRINTLN] pid 0
[1.700000000000:PRINTLN] period 100ms
[1.700000000000:PRINTLN] offset 0
[1.700000000000:PRINTLN] curr 1s700ms
[1.700000000000:PRINTLN] last 1s600ms
[1.700000000000:tut-introspection:TASK_FINISHED] 'p1'
[1.800000000000:tut-introspection:STARTING_TASK] 'p1'
[1.800000000000:PRINTLN] pid 0
[1.800000000000:PRINTLN] period 100ms
[1.800000000000:PRINTLN] offset 0
[1.800000000000:PRINTLN] curr 1s800ms
[1.800000000000:PRINTLN] last 1s700ms
[1.800000000000:tut-introspection:TASK_FINISHED] 'p1'
[1.900000000000:tut-introspection:STARTING_TASK] 'p1'
[1.900000000000:PRINTLN] pid 0
[1.900000000000:PRINTLN] period 100ms
[1.900000000000:PRINTLN] offset 0
[1.900000000000:PRINTLN] curr 1s900ms
[1.900000000000:PRINTLN] last 1s800ms
[1.900000000000:tut-introspection:TASK_FINISHED] 'p1'
[2.000000000000:tut-introspection:STARTING_TASK] 'p1'
[2.000000000000:PRINTLN] pid 0
[2.000000000000:PRINTLN] period 100ms
[2.000000000000:PRINTLN] offset 0
[2.000000000000:PRINTLN] curr 2s
[2.000000000000:PRINTLN] last 1s900ms
[2.000000000000:tut-introspection:TASK_FINISHED] 'p1'
[2.100000000000:tut-introspection:STARTING_TASK] 'p1'
[2.100000000000:PRINTLN] pid 0
[2.100000000000:PRINTLN] period 100ms
[2.100000000000:PRINTLN] offset 0
[2.100000000000:PRINTLN] curr 2s100ms
[2.100000000000:PRINTLN] last 2s
[2.100000000000:tut-introspection:TASK_FINISHED] 'p1'
[2.200000000000:tut-introspection:STARTING_TASK] 'p1'
[2.200000000000:PRINTLN] pid 0
[2.200000000000:PRINTLN] period 100ms
[2.200000000000:PRINTLN] offset 0
[2.200000000000:PRINTLN] curr 2s200ms
[2.200000000000:PRINTLN] last 2s100ms
[2.200000000000:tut-introspection:TASK_FINISHED] 'p1'
[2.300000000000:tut-introspection:STARTING_TASK] 'p1'
[2.300000000000:PRINTLN] pid 0
[2.300000000000:PRINTLN] period 100ms
[2.300000000000:PRINTLN] offset 0
[2.300000000000:PRINTLN] curr 2s300ms
[2.300000000000:PRINTLN] last 2s200ms
[2.300000000000:tut-introspection:TASK_FINISHED] 'p1'
[2.400000000000:tut-introspection:STARTING_TASK] 'p1'
[2.400000000000:PRINTLN] pid 0
[2.400000000000:PRINTLN] period 100ms
[2.400000000000:PRINTLN] offset 0
[2.400000000000:PRINTLN] curr 2s400ms
[2.400000000000:PRINTLN] last 2s300ms
[2.400000000000:tut-introspection:TASK_FINISHED] 'p1'
[2.500000000000:tut-introspection:STARTING_TASK] 'p1'
[2.500000000000:PRINTLN] pid 0
[2.500000000000:PRINTLN] period 100ms
[2.500000000000:PRINTLN] offset 0
[2.500000000000:PRINTLN] curr 2s500ms
[2.500000000000:PRINTLN] last 2s400ms
[2.500000000000:tut-introspection:TASK_FINISHED] 'p1'
[2.600000000000:tut-introspection:STARTING_TASK] 'p1'
[2.600000000000:PRINTLN] pid 0
[2.600000000000:PRINTLN] period 100ms
[2.600000000000:PRINTLN] offset 0
[2.600000000000:PRINTLN] curr 2s600ms
[2.600000000000:PRINTLN] last 2s500ms
[2.600000000000:tut-introspection:TASK_FINISHED] 'p1'
[2.700000000000:tut-introspection:STARTING_TASK] 'p1'
[2.700000000000:PRINTLN] pid 0
[2.700000000000:PRINTLN] period 100ms
[2.700000000000:PRINTLN] offset 0
[2.700000000000:PRINTLN] curr 2s700ms
[2.700000000000:PRINTLN] last 2s600ms
[2.700000000000:tut-introspection:TASK_FINISHED] 'p1'
[2.800000000000:tut-introspection:STARTING_TASK] 'p1'
[2.800000000000:PRINTLN] pid 0
[2.800000000000:PRINTLN] period 100ms
[2.800000000000:PRINTLN] offset 0
[2.800000000000:PRINTLN] curr 2s800ms
[2.800000000000:PRINTLN] last 2s700ms
[2.800000000000:tut-introspection:TASK_FINISHED] 'p1'
[2.900000000000:tut-introspection:STARTING_TASK] 'p1'
[2.900000000000:PRINTLN] pid 0
[2.900000000000:PRINTLN] period 100ms
[2.900000000000:PRINTLN] offset 0
[2.900000000000:PRINTLN] curr 2s900ms
[2.900000000000:PRINTLN] last 2s800ms
[2.900000000000:tut-introspection:TASK_FINISHED] 'p1'
[3.000000000000:tut-introspection:STARTING_TASK] 'p1'
[3.000000000000:PRINTLN] pid 0
[3.000000000000:PRINTLN] period 100ms
[3.000000000000:PRINTLN] offset 0
[3.000000000000:PRINTLN] curr 3s
[3.000000000000:PRINTLN] last 2s900ms
[3.000000000000:tut-introspection:TASK_FINISHED] 'p1'
EXIT (SUCCESS) AT 3s (3000000000000)