CPAL Playground


for ms or try the desktop editor with advanced diagram views

Quiet mode disabled
[0.000000000000:ASSIGN] Assign cpal_system new value: Scheduling_Policy.FIFO
[0.000000000000:ASSIGN][0.000000000000] Pushed task1 new value: 
[0.000000000000:ASSIGN][0.000000000000] Pushed task1 new value: 
[0.000000000000:require-activation:STARTING_TASK] 'task1'
[0.000000000000:STATE] process "My_Process", instance "task1", state "Main"
[0.000000000000:PRINTLN] Current activation released at 0
[0.000000000000:PRINTLN] Creating two new activations
[0.000000000000:PRINTLN] An activation scheduled in 5ms
[0.000000000000:PRINTLN] An activation scheduled in 50ms
[0.000000000000:PRINTLN] An activation scheduled in 55ms
[0.000000000000:require-activation:TASK_FINISHED] 'task1'
[0.005000000000:require-activation:STARTING_TASK] 'task1'
[0.005000000000:PRINTLN] Current activation released at 5ms
[0.005000000000:PRINTLN] An activation scheduled in 45ms
[0.005000000000:PRINTLN] An activation scheduled in 50ms
[0.005000000000:require-activation:TASK_FINISHED] 'task1'
[0.050000000000:require-activation:STARTING_TASK] 'task1'
[0.050000000000:PRINTLN] Current activation released at 50ms
[0.050000000000:PRINTLN] Creating two new activations
[0.050000000000:PRINTLN] An activation scheduled in 5ms
[0.050000000000:PRINTLN] An activation scheduled in 50ms
[0.050000000000:PRINTLN] An activation scheduled in 55ms
[0.050000000000:require-activation:TASK_FINISHED] 'task1'
[0.055000000000:require-activation:STARTING_TASK] 'task1'
[0.055000000000:PRINTLN] Current activation released at 55ms
[0.055000000000:PRINTLN] An activation scheduled in 45ms
[0.055000000000:PRINTLN] An activation scheduled in 50ms
[0.055000000000:require-activation:TASK_FINISHED] 'task1'
[0.100000000000:require-activation:STARTING_TASK] 'task1'
[0.100000000000:PRINTLN] Current activation released at 100ms
[0.100000000000:PRINTLN] Creating two new activations
[0.100000000000:PRINTLN] An activation scheduled in 5ms
[0.100000000000:PRINTLN] An activation scheduled in 50ms
[0.100000000000:PRINTLN] An activation scheduled in 55ms
[0.100000000000:require-activation:TASK_FINISHED] 'task1'
[0.105000000000:require-activation:STARTING_TASK] 'task1'
[0.105000000000:PRINTLN] Current activation released at 105ms
[0.105000000000:PRINTLN] An activation scheduled in 45ms
[0.105000000000:PRINTLN] An activation scheduled in 50ms
[0.105000000000:require-activation:TASK_FINISHED] 'task1'
[0.150000000000:require-activation:STARTING_TASK] 'task1'
[0.150000000000:PRINTLN] Current activation released at 150ms
[0.150000000000:PRINTLN] Creating two new activations
[0.150000000000:PRINTLN] An activation scheduled in 5ms
[0.150000000000:PRINTLN] An activation scheduled in 50ms
[0.150000000000:PRINTLN] An activation scheduled in 55ms
[0.150000000000:require-activation:TASK_FINISHED] 'task1'
[0.155000000000:require-activation:STARTING_TASK] 'task1'
[0.155000000000:PRINTLN] Current activation released at 155ms
[0.155000000000:PRINTLN] An activation scheduled in 45ms
[0.155000000000:PRINTLN] An activation scheduled in 50ms
[0.155000000000:require-activation:TASK_FINISHED] 'task1'
[0.200000000000:require-activation:STARTING_TASK] 'task1'
[0.200000000000:PRINTLN] Current activation released at 200ms
[0.200000000000:PRINTLN] Creating two new activations
[0.200000000000:PRINTLN] An activation scheduled in 5ms
[0.200000000000:PRINTLN] An activation scheduled in 50ms
[0.200000000000:PRINTLN] An activation scheduled in 55ms
[0.200000000000:require-activation:TASK_FINISHED] 'task1'
[0.205000000000:require-activation:STARTING_TASK] 'task1'
[0.205000000000:PRINTLN] Current activation released at 205ms
[0.205000000000:PRINTLN] An activation scheduled in 45ms
[0.205000000000:PRINTLN] An activation scheduled in 50ms
[0.205000000000:require-activation:TASK_FINISHED] 'task1'
[0.250000000000:require-activation:STARTING_TASK] 'task1'
[0.250000000000:PRINTLN] Current activation released at 250ms
[0.250000000000:PRINTLN] Creating two new activations
[0.250000000000:PRINTLN] An activation scheduled in 5ms
[0.250000000000:PRINTLN] An activation scheduled in 50ms
[0.250000000000:PRINTLN] An activation scheduled in 55ms
[0.250000000000:require-activation:TASK_FINISHED] 'task1'
[0.255000000000:require-activation:STARTING_TASK] 'task1'
[0.255000000000:PRINTLN] Current activation released at 255ms
[0.255000000000:PRINTLN] An activation scheduled in 45ms
[0.255000000000:PRINTLN] An activation scheduled in 50ms
[0.255000000000:require-activation:TASK_FINISHED] 'task1'
[0.300000000000:require-activation:STARTING_TASK] 'task1'
[0.300000000000:PRINTLN] Current activation released at 300ms
[0.300000000000:PRINTLN] Creating two new activations
[0.300000000000:PRINTLN] An activation scheduled in 5ms
[0.300000000000:PRINTLN] An activation scheduled in 50ms
[0.300000000000:PRINTLN] An activation scheduled in 55ms
[0.300000000000:require-activation:TASK_FINISHED] 'task1'
[0.305000000000:require-activation:STARTING_TASK] 'task1'
[0.305000000000:PRINTLN] Current activation released at 305ms
[0.305000000000:PRINTLN] An activation scheduled in 45ms
[0.305000000000:PRINTLN] An activation scheduled in 50ms
[0.305000000000:require-activation:TASK_FINISHED] 'task1'
[0.350000000000:require-activation:STARTING_TASK] 'task1'
[0.350000000000:PRINTLN] Current activation released at 350ms
[0.350000000000:PRINTLN] Creating two new activations
[0.350000000000:PRINTLN] An activation scheduled in 5ms
[0.350000000000:PRINTLN] An activation scheduled in 50ms
[0.350000000000:PRINTLN] An activation scheduled in 55ms
[0.350000000000:require-activation:TASK_FINISHED] 'task1'
[0.355000000000:require-activation:STARTING_TASK] 'task1'
[0.355000000000:PRINTLN] Current activation released at 355ms
[0.355000000000:PRINTLN] An activation scheduled in 45ms
[0.355000000000:PRINTLN] An activation scheduled in 50ms
[0.355000000000:require-activation:TASK_FINISHED] 'task1'
[0.400000000000:require-activation:STARTING_TASK] 'task1'
[0.400000000000:PRINTLN] Current activation released at 400ms
[0.400000000000:PRINTLN] Creating two new activations
[0.400000000000:PRINTLN] An activation scheduled in 5ms
[0.400000000000:PRINTLN] An activation scheduled in 50ms
[0.400000000000:PRINTLN] An activation scheduled in 55ms
[0.400000000000:require-activation:TASK_FINISHED] 'task1'
[0.405000000000:require-activation:STARTING_TASK] 'task1'
[0.405000000000:PRINTLN] Current activation released at 405ms
[0.405000000000:PRINTLN] An activation scheduled in 45ms
[0.405000000000:PRINTLN] An activation scheduled in 50ms
[0.405000000000:require-activation:TASK_FINISHED] 'task1'
[0.450000000000:require-activation:STARTING_TASK] 'task1'
[0.450000000000:PRINTLN] Current activation released at 450ms
[0.450000000000:PRINTLN] Creating two new activations
[0.450000000000:PRINTLN] An activation scheduled in 5ms
[0.450000000000:PRINTLN] An activation scheduled in 50ms
[0.450000000000:PRINTLN] An activation scheduled in 55ms
[0.450000000000:require-activation:TASK_FINISHED] 'task1'
[0.455000000000:require-activation:STARTING_TASK] 'task1'
[0.455000000000:PRINTLN] Current activation released at 455ms
[0.455000000000:PRINTLN] An activation scheduled in 45ms
[0.455000000000:PRINTLN] An activation scheduled in 50ms
[0.455000000000:require-activation:TASK_FINISHED] 'task1'
[0.500000000000:require-activation:STARTING_TASK] 'task1'
[0.500000000000:PRINTLN] Current activation released at 500ms
[0.500000000000:PRINTLN] Creating two new activations
[0.500000000000:PRINTLN] An activation scheduled in 5ms
[0.500000000000:PRINTLN] An activation scheduled in 50ms
[0.500000000000:PRINTLN] An activation scheduled in 55ms
[0.500000000000:require-activation:TASK_FINISHED] 'task1'
[0.505000000000:require-activation:STARTING_TASK] 'task1'
[0.505000000000:PRINTLN] Current activation released at 505ms
[0.505000000000:PRINTLN] An activation scheduled in 45ms
[0.505000000000:PRINTLN] An activation scheduled in 50ms
[0.505000000000:require-activation:TASK_FINISHED] 'task1'
[0.550000000000:require-activation:STARTING_TASK] 'task1'
[0.550000000000:PRINTLN] Current activation released at 550ms
[0.550000000000:PRINTLN] Creating two new activations
[0.550000000000:PRINTLN] An activation scheduled in 5ms
[0.550000000000:PRINTLN] An activation scheduled in 50ms
[0.550000000000:PRINTLN] An activation scheduled in 55ms
[0.550000000000:require-activation:TASK_FINISHED] 'task1'
[0.555000000000:require-activation:STARTING_TASK] 'task1'
[0.555000000000:PRINTLN] Current activation released at 555ms
[0.555000000000:PRINTLN] An activation scheduled in 45ms
[0.555000000000:PRINTLN] An activation scheduled in 50ms
[0.555000000000:require-activation:TASK_FINISHED] 'task1'
[0.600000000000:require-activation:STARTING_TASK] 'task1'
[0.600000000000:PRINTLN] Current activation released at 600ms
[0.600000000000:PRINTLN] Creating two new activations
[0.600000000000:PRINTLN] An activation scheduled in 5ms
[0.600000000000:PRINTLN] An activation scheduled in 50ms
[0.600000000000:PRINTLN] An activation scheduled in 55ms
[0.600000000000:require-activation:TASK_FINISHED] 'task1'
[0.605000000000:require-activation:STARTING_TASK] 'task1'
[0.605000000000:PRINTLN] Current activation released at 605ms
[0.605000000000:PRINTLN] An activation scheduled in 45ms
[0.605000000000:PRINTLN] An activation scheduled in 50ms
[0.605000000000:require-activation:TASK_FINISHED] 'task1'
[0.650000000000:require-activation:STARTING_TASK] 'task1'
[0.650000000000:PRINTLN] Current activation released at 650ms
[0.650000000000:PRINTLN] Creating two new activations
[0.650000000000:PRINTLN] An activation scheduled in 5ms
[0.650000000000:PRINTLN] An activation scheduled in 50ms
[0.650000000000:PRINTLN] An activation scheduled in 55ms
[0.650000000000:require-activation:TASK_FINISHED] 'task1'
[0.655000000000:require-activation:STARTING_TASK] 'task1'
[0.655000000000:PRINTLN] Current activation released at 655ms
[0.655000000000:PRINTLN] An activation scheduled in 45ms
[0.655000000000:PRINTLN] An activation scheduled in 50ms
[0.655000000000:require-activation:TASK_FINISHED] 'task1'
[0.700000000000:require-activation:STARTING_TASK] 'task1'
[0.700000000000:PRINTLN] Current activation released at 700ms
[0.700000000000:PRINTLN] Creating two new activations
[0.700000000000:PRINTLN] An activation scheduled in 5ms
[0.700000000000:PRINTLN] An activation scheduled in 50ms
[0.700000000000:PRINTLN] An activation scheduled in 55ms
[0.700000000000:require-activation:TASK_FINISHED] 'task1'
[0.705000000000:require-activation:STARTING_TASK] 'task1'
[0.705000000000:PRINTLN] Current activation released at 705ms
[0.705000000000:PRINTLN] An activation scheduled in 45ms
[0.705000000000:PRINTLN] An activation scheduled in 50ms
[0.705000000000:require-activation:TASK_FINISHED] 'task1'
[0.750000000000:require-activation:STARTING_TASK] 'task1'
[0.750000000000:PRINTLN] Current activation released at 750ms
[0.750000000000:PRINTLN] Creating two new activations
[0.750000000000:PRINTLN] An activation scheduled in 5ms
[0.750000000000:PRINTLN] An activation scheduled in 50ms
[0.750000000000:PRINTLN] An activation scheduled in 55ms
[0.750000000000:require-activation:TASK_FINISHED] 'task1'
[0.755000000000:require-activation:STARTING_TASK] 'task1'
[0.755000000000:PRINTLN] Current activation released at 755ms
[0.755000000000:PRINTLN] An activation scheduled in 45ms
[0.755000000000:PRINTLN] An activation scheduled in 50ms
[0.755000000000:require-activation:TASK_FINISHED] 'task1'
[0.800000000000:require-activation:STARTING_TASK] 'task1'
[0.800000000000:PRINTLN] Current activation released at 800ms
[0.800000000000:PRINTLN] Creating two new activations
[0.800000000000:PRINTLN] An activation scheduled in 5ms
[0.800000000000:PRINTLN] An activation scheduled in 50ms
[0.800000000000:PRINTLN] An activation scheduled in 55ms
[0.800000000000:require-activation:TASK_FINISHED] 'task1'
[0.805000000000:require-activation:STARTING_TASK] 'task1'
[0.805000000000:PRINTLN] Current activation released at 805ms
[0.805000000000:PRINTLN] An activation scheduled in 45ms
[0.805000000000:PRINTLN] An activation scheduled in 50ms
[0.805000000000:require-activation:TASK_FINISHED] 'task1'
[0.850000000000:require-activation:STARTING_TASK] 'task1'
[0.850000000000:PRINTLN] Current activation released at 850ms
[0.850000000000:PRINTLN] Creating two new activations
[0.850000000000:PRINTLN] An activation scheduled in 5ms
[0.850000000000:PRINTLN] An activation scheduled in 50ms
[0.850000000000:PRINTLN] An activation scheduled in 55ms
[0.850000000000:require-activation:TASK_FINISHED] 'task1'
[0.855000000000:require-activation:STARTING_TASK] 'task1'
[0.855000000000:PRINTLN] Current activation released at 855ms
[0.855000000000:PRINTLN] An activation scheduled in 45ms
[0.855000000000:PRINTLN] An activation scheduled in 50ms
[0.855000000000:require-activation:TASK_FINISHED] 'task1'
[0.900000000000:require-activation:STARTING_TASK] 'task1'
[0.900000000000:PRINTLN] Current activation released at 900ms
[0.900000000000:PRINTLN] Creating two new activations
[0.900000000000:PRINTLN] An activation scheduled in 5ms
[0.900000000000:PRINTLN] An activation scheduled in 50ms
[0.900000000000:PRINTLN] An activation scheduled in 55ms
[0.900000000000:require-activation:TASK_FINISHED] 'task1'
[0.905000000000:require-activation:STARTING_TASK] 'task1'
[0.905000000000:PRINTLN] Current activation released at 905ms
[0.905000000000:PRINTLN] An activation scheduled in 45ms
[0.905000000000:PRINTLN] An activation scheduled in 50ms
[0.905000000000:require-activation:TASK_FINISHED] 'task1'
[0.950000000000:require-activation:STARTING_TASK] 'task1'
[0.950000000000:PRINTLN] Current activation released at 950ms
[0.950000000000:PRINTLN] Creating two new activations
[0.950000000000:PRINTLN] An activation scheduled in 5ms
[0.950000000000:PRINTLN] An activation scheduled in 50ms
[0.950000000000:PRINTLN] An activation scheduled in 55ms
[0.950000000000:require-activation:TASK_FINISHED] 'task1'
[0.955000000000:require-activation:STARTING_TASK] 'task1'
[0.955000000000:PRINTLN] Current activation released at 955ms
[0.955000000000:PRINTLN] An activation scheduled in 45ms
[0.955000000000:PRINTLN] An activation scheduled in 50ms
[0.955000000000:require-activation:TASK_FINISHED] 'task1'
[1.000000000000:require-activation:STARTING_TASK] 'task1'
[1.000000000000:PRINTLN] Current activation released at 1s
[1.000000000000:PRINTLN] Creating two new activations
[1.000000000000:PRINTLN] An activation scheduled in 5ms
[1.000000000000:PRINTLN] An activation scheduled in 50ms
[1.000000000000:PRINTLN] An activation scheduled in 55ms
[1.000000000000:require-activation:TASK_FINISHED] 'task1'
[1.005000000000:require-activation:STARTING_TASK] 'task1'
[1.005000000000:PRINTLN] Current activation released at 1s5ms
[1.005000000000:PRINTLN] An activation scheduled in 45ms
[1.005000000000:PRINTLN] An activation scheduled in 50ms
[1.005000000000:require-activation:TASK_FINISHED] 'task1'
[1.050000000000:require-activation:STARTING_TASK] 'task1'
[1.050000000000:PRINTLN] Current activation released at 1s50ms
[1.050000000000:PRINTLN] Creating two new activations
[1.050000000000:PRINTLN] An activation scheduled in 5ms
[1.050000000000:PRINTLN] An activation scheduled in 50ms
[1.050000000000:PRINTLN] An activation scheduled in 55ms
[1.050000000000:require-activation:TASK_FINISHED] 'task1'
[1.055000000000:require-activation:STARTING_TASK] 'task1'
[1.055000000000:PRINTLN] Current activation released at 1s55ms
[1.055000000000:PRINTLN] An activation scheduled in 45ms
[1.055000000000:PRINTLN] An activation scheduled in 50ms
[1.055000000000:require-activation:TASK_FINISHED] 'task1'
[1.100000000000:require-activation:STARTING_TASK] 'task1'
[1.100000000000:PRINTLN] Current activation released at 1s100ms
[1.100000000000:PRINTLN] Creating two new activations
[1.100000000000:PRINTLN] An activation scheduled in 5ms
[1.100000000000:PRINTLN] An activation scheduled in 50ms
[1.100000000000:PRINTLN] An activation scheduled in 55ms
[1.100000000000:require-activation:TASK_FINISHED] 'task1'
[1.105000000000:require-activation:STARTING_TASK] 'task1'
[1.105000000000:PRINTLN] Current activation released at 1s105ms
[1.105000000000:PRINTLN] An activation scheduled in 45ms
[1.105000000000:PRINTLN] An activation scheduled in 50ms
[1.105000000000:require-activation:TASK_FINISHED] 'task1'
[1.150000000000:require-activation:STARTING_TASK] 'task1'
[1.150000000000:PRINTLN] Current activation released at 1s150ms
[1.150000000000:PRINTLN] Creating two new activations
[1.150000000000:PRINTLN] An activation scheduled in 5ms
[1.150000000000:PRINTLN] An activation scheduled in 50ms
[1.150000000000:PRINTLN] An activation scheduled in 55ms
[1.150000000000:require-activation:TASK_FINISHED] 'task1'
[1.155000000000:require-activation:STARTING_TASK] 'task1'
[1.155000000000:PRINTLN] Current activation released at 1s155ms
[1.155000000000:PRINTLN] An activation scheduled in 45ms
[1.155000000000:PRINTLN] An activation scheduled in 50ms
[1.155000000000:require-activation:TASK_FINISHED] 'task1'
[1.200000000000:require-activation:STARTING_TASK] 'task1'
[1.200000000000:PRINTLN] Current activation released at 1s200ms
[1.200000000000:PRINTLN] Creating two new activations
[1.200000000000:PRINTLN] An activation scheduled in 5ms
[1.200000000000:PRINTLN] An activation scheduled in 50ms
[1.200000000000:PRINTLN] An activation scheduled in 55ms
[1.200000000000:require-activation:TASK_FINISHED] 'task1'
[1.205000000000:require-activation:STARTING_TASK] 'task1'
[1.205000000000:PRINTLN] Current activation released at 1s205ms
[1.205000000000:PRINTLN] An activation scheduled in 45ms
[1.205000000000:PRINTLN] An activation scheduled in 50ms
[1.205000000000:require-activation:TASK_FINISHED] 'task1'
[1.250000000000:require-activation:STARTING_TASK] 'task1'
[1.250000000000:PRINTLN] Current activation released at 1s250ms
[1.250000000000:PRINTLN] Creating two new activations
[1.250000000000:PRINTLN] An activation scheduled in 5ms
[1.250000000000:PRINTLN] An activation scheduled in 50ms
[1.250000000000:PRINTLN] An activation scheduled in 55ms
[1.250000000000:require-activation:TASK_FINISHED] 'task1'
[1.255000000000:require-activation:STARTING_TASK] 'task1'
[1.255000000000:PRINTLN] Current activation released at 1s255ms
[1.255000000000:PRINTLN] An activation scheduled in 45ms
[1.255000000000:PRINTLN] An activation scheduled in 50ms
[1.255000000000:require-activation:TASK_FINISHED] 'task1'
[1.300000000000:require-activation:STARTING_TASK] 'task1'
[1.300000000000:PRINTLN] Current activation released at 1s300ms
[1.300000000000:PRINTLN] Creating two new activations
[1.300000000000:PRINTLN] An activation scheduled in 5ms
[1.300000000000:PRINTLN] An activation scheduled in 50ms
[1.300000000000:PRINTLN] An activation scheduled in 55ms
[1.300000000000:require-activation:TASK_FINISHED] 'task1'
[1.305000000000:require-activation:STARTING_TASK] 'task1'
[1.305000000000:PRINTLN] Current activation released at 1s305ms
[1.305000000000:PRINTLN] An activation scheduled in 45ms
[1.305000000000:PRINTLN] An activation scheduled in 50ms
[1.305000000000:require-activation:TASK_FINISHED] 'task1'
[1.350000000000:require-activation:STARTING_TASK] 'task1'
[1.350000000000:PRINTLN] Current activation released at 1s350ms
[1.350000000000:PRINTLN] Creating two new activations
[1.350000000000:PRINTLN] An activation scheduled in 5ms
[1.350000000000:PRINTLN] An activation scheduled in 50ms
[1.350000000000:PRINTLN] An activation scheduled in 55ms
[1.350000000000:require-activation:TASK_FINISHED] 'task1'
[1.355000000000:require-activation:STARTING_TASK] 'task1'
[1.355000000000:PRINTLN] Current activation released at 1s355ms
[1.355000000000:PRINTLN] An activation scheduled in 45ms
[1.355000000000:PRINTLN] An activation scheduled in 50ms
[1.355000000000:require-activation:TASK_FINISHED] 'task1'
[1.400000000000:require-activation:STARTING_TASK] 'task1'
[1.400000000000:PRINTLN] Current activation released at 1s400ms
[1.400000000000:PRINTLN] Creating two new activations
[1.400000000000:PRINTLN] An activation scheduled in 5ms
[1.400000000000:PRINTLN] An activation scheduled in 50ms
[1.400000000000:PRINTLN] An activation scheduled in 55ms
[1.400000000000:require-activation:TASK_FINISHED] 'task1'
[1.405000000000:require-activation:STARTING_TASK] 'task1'
[1.405000000000:PRINTLN] Current activation released at 1s405ms
[1.405000000000:PRINTLN] An activation scheduled in 45ms
[1.405000000000:PRINTLN] An activation scheduled in 50ms
[1.405000000000:require-activation:TASK_FINISHED] 'task1'
[1.450000000000:require-activation:STARTING_TASK] 'task1'
[1.450000000000:PRINTLN] Current activation released at 1s450ms
[1.450000000000:PRINTLN] Creating two new activations
[1.450000000000:PRINTLN] An activation scheduled in 5ms
[1.450000000000:PRINTLN] An activation scheduled in 50ms
[1.450000000000:PRINTLN] An activation scheduled in 55ms
[1.450000000000:require-activation:TASK_FINISHED] 'task1'
[1.455000000000:require-activation:STARTING_TASK] 'task1'
[1.455000000000:PRINTLN] Current activation released at 1s455ms
[1.455000000000:PRINTLN] An activation scheduled in 45ms
[1.455000000000:PRINTLN] An activation scheduled in 50ms
[1.455000000000:require-activation:TASK_FINISHED] 'task1'
[1.500000000000:require-activation:STARTING_TASK] 'task1'
[1.500000000000:PRINTLN] Current activation released at 1s500ms
[1.500000000000:PRINTLN] Creating two new activations
[1.500000000000:PRINTLN] An activation scheduled in 5ms
[1.500000000000:PRINTLN] An activation scheduled in 50ms
[1.500000000000:PRINTLN] An activation scheduled in 55ms
[1.500000000000:require-activation:TASK_FINISHED] 'task1'
[1.505000000000:require-activation:STARTING_TASK] 'task1'
[1.505000000000:PRINTLN] Current activation released at 1s505ms
[1.505000000000:PRINTLN] An activation scheduled in 45ms
[1.505000000000:PRINTLN] An activation scheduled in 50ms
[1.505000000000:require-activation:TASK_FINISHED] 'task1'
[1.550000000000:require-activation:STARTING_TASK] 'task1'
[1.550000000000:PRINTLN] Current activation released at 1s550ms
[1.550000000000:PRINTLN] Creating two new activations
[1.550000000000:PRINTLN] An activation scheduled in 5ms
[1.550000000000:PRINTLN] An activation scheduled in 50ms
[1.550000000000:PRINTLN] An activation scheduled in 55ms
[1.550000000000:require-activation:TASK_FINISHED] 'task1'
[1.555000000000:require-activation:STARTING_TASK] 'task1'
[1.555000000000:PRINTLN] Current activation released at 1s555ms
[1.555000000000:PRINTLN] An activation scheduled in 45ms
[1.555000000000:PRINTLN] An activation scheduled in 50ms
[1.555000000000:require-activation:TASK_FINISHED] 'task1'
[1.600000000000:require-activation:STARTING_TASK] 'task1'
[1.600000000000:PRINTLN] Current activation released at 1s600ms
[1.600000000000:PRINTLN] Creating two new activations
[1.600000000000:PRINTLN] An activation scheduled in 5ms
[1.600000000000:PRINTLN] An activation scheduled in 50ms
[1.600000000000:PRINTLN] An activation scheduled in 55ms
[1.600000000000:require-activation:TASK_FINISHED] 'task1'
[1.605000000000:require-activation:STARTING_TASK] 'task1'
[1.605000000000:PRINTLN] Current activation released at 1s605ms
[1.605000000000:PRINTLN] An activation scheduled in 45ms
[1.605000000000:PRINTLN] An activation scheduled in 50ms
[1.605000000000:require-activation:TASK_FINISHED] 'task1'
[1.650000000000:require-activation:STARTING_TASK] 'task1'
[1.650000000000:PRINTLN] Current activation released at 1s650ms
[1.650000000000:PRINTLN] Creating two new activations
[1.650000000000:PRINTLN] An activation scheduled in 5ms
[1.650000000000:PRINTLN] An activation scheduled in 50ms
[1.650000000000:PRINTLN] An activation scheduled in 55ms
[1.650000000000:require-activation:TASK_FINISHED] 'task1'
[1.655000000000:require-activation:STARTING_TASK] 'task1'
[1.655000000000:PRINTLN] Current activation released at 1s655ms
[1.655000000000:PRINTLN] An activation scheduled in 45ms
[1.655000000000:PRINTLN] An activation scheduled in 50ms
[1.655000000000:require-activation:TASK_FINISHED] 'task1'
[1.700000000000:require-activation:STARTING_TASK] 'task1'
[1.700000000000:PRINTLN] Current activation released at 1s700ms
[1.700000000000:PRINTLN] Creating two new activations
[1.700000000000:PRINTLN] An activation scheduled in 5ms
[1.700000000000:PRINTLN] An activation scheduled in 50ms
[1.700000000000:PRINTLN] An activation scheduled in 55ms
[1.700000000000:require-activation:TASK_FINISHED] 'task1'
[1.705000000000:require-activation:STARTING_TASK] 'task1'
[1.705000000000:PRINTLN] Current activation released at 1s705ms
[1.705000000000:PRINTLN] An activation scheduled in 45ms
[1.705000000000:PRINTLN] An activation scheduled in 50ms
[1.705000000000:require-activation:TASK_FINISHED] 'task1'
[1.750000000000:require-activation:STARTING_TASK] 'task1'
[1.750000000000:PRINTLN] Current activation released at 1s750ms
[1.750000000000:PRINTLN] Creating two new activations
[1.750000000000:PRINTLN] An activation scheduled in 5ms
[1.750000000000:PRINTLN] An activation scheduled in 50ms
[1.750000000000:PRINTLN] An activation scheduled in 55ms
[1.750000000000:require-activation:TASK_FINISHED] 'task1'
[1.755000000000:require-activation:STARTING_TASK] 'task1'
[1.755000000000:PRINTLN] Current activation released at 1s755ms
[1.755000000000:PRINTLN] An activation scheduled in 45ms
[1.755000000000:PRINTLN] An activation scheduled in 50ms
[1.755000000000:require-activation:TASK_FINISHED] 'task1'
[1.800000000000:require-activation:STARTING_TASK] 'task1'
[1.800000000000:PRINTLN] Current activation released at 1s800ms
[1.800000000000:PRINTLN] Creating two new activations
[1.800000000000:PRINTLN] An activation scheduled in 5ms
[1.800000000000:PRINTLN] An activation scheduled in 50ms
[1.800000000000:PRINTLN] An activation scheduled in 55ms
[1.800000000000:require-activation:TASK_FINISHED] 'task1'
[1.805000000000:require-activation:STARTING_TASK] 'task1'
[1.805000000000:PRINTLN] Current activation released at 1s805ms
[1.805000000000:PRINTLN] An activation scheduled in 45ms
[1.805000000000:PRINTLN] An activation scheduled in 50ms
[1.805000000000:require-activation:TASK_FINISHED] 'task1'
[1.850000000000:require-activation:STARTING_TASK] 'task1'
[1.850000000000:PRINTLN] Current activation released at 1s850ms
[1.850000000000:PRINTLN] Creating two new activations
[1.850000000000:PRINTLN] An activation scheduled in 5ms
[1.850000000000:PRINTLN] An activation scheduled in 50ms
[1.850000000000:PRINTLN] An activation scheduled in 55ms
[1.850000000000:require-activation:TASK_FINISHED] 'task1'
[1.855000000000:require-activation:STARTING_TASK] 'task1'
[1.855000000000:PRINTLN] Current activation released at 1s855ms
[1.855000000000:PRINTLN] An activation scheduled in 45ms
[1.855000000000:PRINTLN] An activation scheduled in 50ms
[1.855000000000:require-activation:TASK_FINISHED] 'task1'
[1.900000000000:require-activation:STARTING_TASK] 'task1'
[1.900000000000:PRINTLN] Current activation released at 1s900ms
[1.900000000000:PRINTLN] Creating two new activations
[1.900000000000:PRINTLN] An activation scheduled in 5ms
[1.900000000000:PRINTLN] An activation scheduled in 50ms
[1.900000000000:PRINTLN] An activation scheduled in 55ms
[1.900000000000:require-activation:TASK_FINISHED] 'task1'
[1.905000000000:require-activation:STARTING_TASK] 'task1'
[1.905000000000:PRINTLN] Current activation released at 1s905ms
[1.905000000000:PRINTLN] An activation scheduled in 45ms
[1.905000000000:PRINTLN] An activation scheduled in 50ms
[1.905000000000:require-activation:TASK_FINISHED] 'task1'
[1.950000000000:require-activation:STARTING_TASK] 'task1'
[1.950000000000:PRINTLN] Current activation released at 1s950ms
[1.950000000000:PRINTLN] Creating two new activations
[1.950000000000:PRINTLN] An activation scheduled in 5ms
[1.950000000000:PRINTLN] An activation scheduled in 50ms
[1.950000000000:PRINTLN] An activation scheduled in 55ms
[1.950000000000:require-activation:TASK_FINISHED] 'task1'
[1.955000000000:require-activation:STARTING_TASK] 'task1'
[1.955000000000:PRINTLN] Current activation released at 1s955ms
[1.955000000000:PRINTLN] An activation scheduled in 45ms
[1.955000000000:PRINTLN] An activation scheduled in 50ms
[1.955000000000:require-activation:TASK_FINISHED] 'task1'
[2.000000000000:require-activation:STARTING_TASK] 'task1'
[2.000000000000:PRINTLN] Current activation released at 2s
[2.000000000000:PRINTLN] Creating two new activations
[2.000000000000:PRINTLN] An activation scheduled in 5ms
[2.000000000000:PRINTLN] An activation scheduled in 50ms
[2.000000000000:PRINTLN] An activation scheduled in 55ms
[2.000000000000:require-activation:TASK_FINISHED] 'task1'
[2.005000000000:require-activation:STARTING_TASK] 'task1'
[2.005000000000:PRINTLN] Current activation released at 2s5ms
[2.005000000000:PRINTLN] An activation scheduled in 45ms
[2.005000000000:PRINTLN] An activation scheduled in 50ms
[2.005000000000:require-activation:TASK_FINISHED] 'task1'
[2.050000000000:require-activation:STARTING_TASK] 'task1'
[2.050000000000:PRINTLN] Current activation released at 2s50ms
[2.050000000000:PRINTLN] Creating two new activations
[2.050000000000:PRINTLN] An activation scheduled in 5ms
[2.050000000000:PRINTLN] An activation scheduled in 50ms
[2.050000000000:PRINTLN] An activation scheduled in 55ms
[2.050000000000:require-activation:TASK_FINISHED] 'task1'
[2.055000000000:require-activation:STARTING_TASK] 'task1'
[2.055000000000:PRINTLN] Current activation released at 2s55ms
[2.055000000000:PRINTLN] An activation scheduled in 45ms
[2.055000000000:PRINTLN] An activation scheduled in 50ms
[2.055000000000:require-activation:TASK_FINISHED] 'task1'
[2.100000000000:require-activation:STARTING_TASK] 'task1'
[2.100000000000:PRINTLN] Current activation released at 2s100ms
[2.100000000000:PRINTLN] Creating two new activations
[2.100000000000:PRINTLN] An activation scheduled in 5ms
[2.100000000000:PRINTLN] An activation scheduled in 50ms
[2.100000000000:PRINTLN] An activation scheduled in 55ms
[2.100000000000:require-activation:TASK_FINISHED] 'task1'
[2.105000000000:require-activation:STARTING_TASK] 'task1'
[2.105000000000:PRINTLN] Current activation released at 2s105ms
[2.105000000000:PRINTLN] An activation scheduled in 45ms
[2.105000000000:PRINTLN] An activation scheduled in 50ms
[2.105000000000:require-activation:TASK_FINISHED] 'task1'
[2.150000000000:require-activation:STARTING_TASK] 'task1'
[2.150000000000:PRINTLN] Current activation released at 2s150ms
[2.150000000000:PRINTLN] Creating two new activations
[2.150000000000:PRINTLN] An activation scheduled in 5ms
[2.150000000000:PRINTLN] An activation scheduled in 50ms
[2.150000000000:PRINTLN] An activation scheduled in 55ms
[2.150000000000:require-activation:TASK_FINISHED] 'task1'
[2.155000000000:require-activation:STARTING_TASK] 'task1'
[2.155000000000:PRINTLN] Current activation released at 2s155ms
[2.155000000000:PRINTLN] An activation scheduled in 45ms
[2.155000000000:PRINTLN] An activation scheduled in 50ms
[2.155000000000:require-activation:TASK_FINISHED] 'task1'
[2.200000000000:require-activation:STARTING_TASK] 'task1'
[2.200000000000:PRINTLN] Current activation released at 2s200ms
[2.200000000000:PRINTLN] Creating two new activations
[2.200000000000:PRINTLN] An activation scheduled in 5ms
[2.200000000000:PRINTLN] An activation scheduled in 50ms
[2.200000000000:PRINTLN] An activation scheduled in 55ms
[2.200000000000:require-activation:TASK_FINISHED] 'task1'
[2.205000000000:require-activation:STARTING_TASK] 'task1'
[2.205000000000:PRINTLN] Current activation released at 2s205ms
[2.205000000000:PRINTLN] An activation scheduled in 45ms
[2.205000000000:PRINTLN] An activation scheduled in 50ms
[2.205000000000:require-activation:TASK_FINISHED] 'task1'
[2.250000000000:require-activation:STARTING_TASK] 'task1'
[2.250000000000:PRINTLN] Current activation released at 2s250ms
[2.250000000000:PRINTLN] Creating two new activations
[2.250000000000:PRINTLN] An activation scheduled in 5ms
[2.250000000000:PRINTLN] An activation scheduled in 50ms
[2.250000000000:PRINTLN] An activation scheduled in 55ms
[2.250000000000:require-activation:TASK_FINISHED] 'task1'
[2.255000000000:require-activation:STARTING_TASK] 'task1'
[2.255000000000:PRINTLN] Current activation released at 2s255ms
[2.255000000000:PRINTLN] An activation scheduled in 45ms
[2.255000000000:PRINTLN] An activation scheduled in 50ms
[2.255000000000:require-activation:TASK_FINISHED] 'task1'
[2.300000000000:require-activation:STARTING_TASK] 'task1'
[2.300000000000:PRINTLN] Current activation released at 2s300ms
[2.300000000000:PRINTLN] Creating two new activations
[2.300000000000:PRINTLN] An activation scheduled in 5ms
[2.300000000000:PRINTLN] An activation scheduled in 50ms
[2.300000000000:PRINTLN] An activation scheduled in 55ms
[2.300000000000:require-activation:TASK_FINISHED] 'task1'
[2.305000000000:require-activation:STARTING_TASK] 'task1'
[2.305000000000:PRINTLN] Current activation released at 2s305ms
[2.305000000000:PRINTLN] An activation scheduled in 45ms
[2.305000000000:PRINTLN] An activation scheduled in 50ms
[2.305000000000:require-activation:TASK_FINISHED] 'task1'
[2.350000000000:require-activation:STARTING_TASK] 'task1'
[2.350000000000:PRINTLN] Current activation released at 2s350ms
[2.350000000000:PRINTLN] Creating two new activations
[2.350000000000:PRINTLN] An activation scheduled in 5ms
[2.350000000000:PRINTLN] An activation scheduled in 50ms
[2.350000000000:PRINTLN] An activation scheduled in 55ms
[2.350000000000:require-activation:TASK_FINISHED] 'task1'
[2.355000000000:require-activation:STARTING_TASK] 'task1'
[2.355000000000:PRINTLN] Current activation released at 2s355ms
[2.355000000000:PRINTLN] An activation scheduled in 45ms
[2.355000000000:PRINTLN] An activation scheduled in 50ms
[2.355000000000:require-activation:TASK_FINISHED] 'task1'
[2.400000000000:require-activation:STARTING_TASK] 'task1'
[2.400000000000:PRINTLN] Current activation released at 2s400ms
[2.400000000000:PRINTLN] Creating two new activations
[2.400000000000:PRINTLN] An activation scheduled in 5ms
[2.400000000000:PRINTLN] An activation scheduled in 50ms
[2.400000000000:PRINTLN] An activation scheduled in 55ms
[2.400000000000:require-activation:TASK_FINISHED] 'task1'
[2.405000000000:require-activation:STARTING_TASK] 'task1'
[2.405000000000:PRINTLN] Current activation released at 2s405ms
[2.405000000000:PRINTLN] An activation scheduled in 45ms
[2.405000000000:PRINTLN] An activation scheduled in 50ms
[2.405000000000:require-activation:TASK_FINISHED] 'task1'
[2.450000000000:require-activation:STARTING_TASK] 'task1'
[2.450000000000:PRINTLN] Current activation released at 2s450ms
[2.450000000000:PRINTLN] Creating two new activations
[2.450000000000:PRINTLN] An activation scheduled in 5ms
[2.450000000000:PRINTLN] An activation scheduled in 50ms
[2.450000000000:PRINTLN] An activation scheduled in 55ms
[2.450000000000:require-activation:TASK_FINISHED] 'task1'
[2.455000000000:require-activation:STARTING_TASK] 'task1'
[2.455000000000:PRINTLN] Current activation released at 2s455ms
[2.455000000000:PRINTLN] An activation scheduled in 45ms
[2.455000000000:PRINTLN] An activation scheduled in 50ms
[2.455000000000:require-activation:TASK_FINISHED] 'task1'
[2.500000000000:require-activation:STARTING_TASK] 'task1'
[2.500000000000:PRINTLN] Current activation released at 2s500ms
[2.500000000000:PRINTLN] Creating two new activations
[2.500000000000:PRINTLN] An activation scheduled in 5ms
[2.500000000000:PRINTLN] An activation scheduled in 50ms
[2.500000000000:PRINTLN] An activation scheduled in 55ms
[2.500000000000:require-activation:TASK_FINISHED] 'task1'
[2.505000000000:require-activation:STARTING_TASK] 'task1'
[2.505000000000:PRINTLN] Current activation released at 2s505ms
[2.505000000000:PRINTLN] An activation scheduled in 45ms
[2.505000000000:PRINTLN] An activation scheduled in 50ms
[2.505000000000:require-activation:TASK_FINISHED] 'task1'
[2.550000000000:require-activation:STARTING_TASK] 'task1'
[2.550000000000:PRINTLN] Current activation released at 2s550ms
[2.550000000000:PRINTLN] Creating two new activations
[2.550000000000:PRINTLN] An activation scheduled in 5ms
[2.550000000000:PRINTLN] An activation scheduled in 50ms
[2.550000000000:PRINTLN] An activation scheduled in 55ms
[2.550000000000:require-activation:TASK_FINISHED] 'task1'
[2.555000000000:require-activation:STARTING_TASK] 'task1'
[2.555000000000:PRINTLN] Current activation released at 2s555ms
[2.555000000000:PRINTLN] An activation scheduled in 45ms
[2.555000000000:PRINTLN] An activation scheduled in 50ms
[2.555000000000:require-activation:TASK_FINISHED] 'task1'
[2.600000000000:require-activation:STARTING_TASK] 'task1'
[2.600000000000:PRINTLN] Current activation released at 2s600ms
[2.600000000000:PRINTLN] Creating two new activations
[2.600000000000:PRINTLN] An activation scheduled in 5ms
[2.600000000000:PRINTLN] An activation scheduled in 50ms
[2.600000000000:PRINTLN] An activation scheduled in 55ms
[2.600000000000:require-activation:TASK_FINISHED] 'task1'
[2.605000000000:require-activation:STARTING_TASK] 'task1'
[2.605000000000:PRINTLN] Current activation released at 2s605ms
[2.605000000000:PRINTLN] An activation scheduled in 45ms
[2.605000000000:PRINTLN] An activation scheduled in 50ms
[2.605000000000:require-activation:TASK_FINISHED] 'task1'
[2.650000000000:require-activation:STARTING_TASK] 'task1'
[2.650000000000:PRINTLN] Current activation released at 2s650ms
[2.650000000000:PRINTLN] Creating two new activations
[2.650000000000:PRINTLN] An activation scheduled in 5ms
[2.650000000000:PRINTLN] An activation scheduled in 50ms
[2.650000000000:PRINTLN] An activation scheduled in 55ms
[2.650000000000:require-activation:TASK_FINISHED] 'task1'
[2.655000000000:require-activation:STARTING_TASK] 'task1'
[2.655000000000:PRINTLN] Current activation released at 2s655ms
[2.655000000000:PRINTLN] An activation scheduled in 45ms
[2.655000000000:PRINTLN] An activation scheduled in 50ms
[2.655000000000:require-activation:TASK_FINISHED] 'task1'
[2.700000000000:require-activation:STARTING_TASK] 'task1'
[2.700000000000:PRINTLN] Current activation released at 2s700ms
[2.700000000000:PRINTLN] Creating two new activations
[2.700000000000:PRINTLN] An activation scheduled in 5ms
[2.700000000000:PRINTLN] An activation scheduled in 50ms
[2.700000000000:PRINTLN] An activation scheduled in 55ms
[2.700000000000:require-activation:TASK_FINISHED] 'task1'
[2.705000000000:require-activation:STARTING_TASK] 'task1'
[2.705000000000:PRINTLN] Current activation released at 2s705ms
[2.705000000000:PRINTLN] An activation scheduled in 45ms
[2.705000000000:PRINTLN] An activation scheduled in 50ms
[2.705000000000:require-activation:TASK_FINISHED] 'task1'
[2.750000000000:require-activation:STARTING_TASK] 'task1'
[2.750000000000:PRINTLN] Current activation released at 2s750ms
[2.750000000000:PRINTLN] Creating two new activations
[2.750000000000:PRINTLN] An activation scheduled in 5ms
[2.750000000000:PRINTLN] An activation scheduled in 50ms
[2.750000000000:PRINTLN] An activation scheduled in 55ms
[2.750000000000:require-activation:TASK_FINISHED] 'task1'
[2.755000000000:require-activation:STARTING_TASK] 'task1'
[2.755000000000:PRINTLN] Current activation released at 2s755ms
[2.755000000000:PRINTLN] An activation scheduled in 45ms
[2.755000000000:PRINTLN] An activation scheduled in 50ms
[2.755000000000:require-activation:TASK_FINISHED] 'task1'
[2.800000000000:require-activation:STARTING_TASK] 'task1'
[2.800000000000:PRINTLN] Current activation released at 2s800ms
[2.800000000000:PRINTLN] Creating two new activations
[2.800000000000:PRINTLN] An activation scheduled in 5ms
[2.800000000000:PRINTLN] An activation scheduled in 50ms
[2.800000000000:PRINTLN] An activation scheduled in 55ms
[2.800000000000:require-activation:TASK_FINISHED] 'task1'
[2.805000000000:require-activation:STARTING_TASK] 'task1'
[2.805000000000:PRINTLN] Current activation released at 2s805ms
[2.805000000000:PRINTLN] An activation scheduled in 45ms
[2.805000000000:PRINTLN] An activation scheduled in 50ms
[2.805000000000:require-activation:TASK_FINISHED] 'task1'
[2.850000000000:require-activation:STARTING_TASK] 'task1'
[2.850000000000:PRINTLN] Current activation released at 2s850ms
[2.850000000000:PRINTLN] Creating two new activations
[2.850000000000:PRINTLN] An activation scheduled in 5ms
[2.850000000000:PRINTLN] An activation scheduled in 50ms
[2.850000000000:PRINTLN] An activation scheduled in 55ms
[2.850000000000:require-activation:TASK_FINISHED] 'task1'
[2.855000000000:require-activation:STARTING_TASK] 'task1'
[2.855000000000:PRINTLN] Current activation released at 2s855ms
[2.855000000000:PRINTLN] An activation scheduled in 45ms
[2.855000000000:PRINTLN] An activation scheduled in 50ms
[2.855000000000:require-activation:TASK_FINISHED] 'task1'
[2.900000000000:require-activation:STARTING_TASK] 'task1'
[2.900000000000:PRINTLN] Current activation released at 2s900ms
[2.900000000000:PRINTLN] Creating two new activations
[2.900000000000:PRINTLN] An activation scheduled in 5ms
[2.900000000000:PRINTLN] An activation scheduled in 50ms
[2.900000000000:PRINTLN] An activation scheduled in 55ms
[2.900000000000:require-activation:TASK_FINISHED] 'task1'
[2.905000000000:require-activation:STARTING_TASK] 'task1'
[2.905000000000:PRINTLN] Current activation released at 2s905ms
[2.905000000000:PRINTLN] An activation scheduled in 45ms
[2.905000000000:PRINTLN] An activation scheduled in 50ms
[2.905000000000:require-activation:TASK_FINISHED] 'task1'
[2.950000000000:require-activation:STARTING_TASK] 'task1'
[2.950000000000:PRINTLN] Current activation released at 2s950ms
[2.950000000000:PRINTLN] Creating two new activations
[2.950000000000:PRINTLN] An activation scheduled in 5ms
[2.950000000000:PRINTLN] An activation scheduled in 50ms
[2.950000000000:PRINTLN] An activation scheduled in 55ms
[2.950000000000:require-activation:TASK_FINISHED] 'task1'
[2.955000000000:require-activation:STARTING_TASK] 'task1'
[2.955000000000:PRINTLN] Current activation released at 2s955ms
[2.955000000000:PRINTLN] An activation scheduled in 45ms
[2.955000000000:PRINTLN] An activation scheduled in 50ms
[2.955000000000:require-activation:TASK_FINISHED] 'task1'
[3.000000000000:require-activation:STARTING_TASK] 'task1'
[3.000000000000:PRINTLN] Current activation released at 3s
[3.000000000000:PRINTLN] Creating two new activations
[3.000000000000:PRINTLN] An activation scheduled in 5ms
[3.000000000000:PRINTLN] An activation scheduled in 50ms
[3.000000000000:PRINTLN] An activation scheduled in 55ms
[3.000000000000:require-activation:TASK_FINISHED] 'task1'
EXIT (SUCCESS) AT 3s (3000000000000)