2011-02-15 13:28:47,621 Trac[core] DEBUG: ticker wake up 2011-02-15 13:28:47,621 Trac[core] DEBUG: check existing task 2011-02-15 13:28:47,621 Trac[core] DEBUG: check task mytask 2011-02-15 13:28:47,621 Trac[core] DEBUG: schedule daily is disabled 2011-02-15 13:28:47,622 Trac[scheduler] DEBUG: looking for schedule of type hourly 2011-02-15 13:28:47,622 Trac[scheduler] DEBUG: task [mytask] is scheduled for 5 2011-02-15 13:28:47,622 Trac[scheduler] DEBUG: hourly compare currentTime=time.struct_time(tm_year=2011, tm_mon=2, tm_mday=15, tm_hour=13, tm_min=28, tm_sec=47, tm_wday=1, tm_yday=46, tm_isdst=0) with schedule_value 5 2011-02-15 13:28:47,622 Trac[scheduler] DEBUG: task [mytask] is scheduled for 10 2011-02-15 13:28:47,623 Trac[scheduler] DEBUG: hourly compare currentTime=time.struct_time(tm_year=2011, tm_mon=2, tm_mday=15, tm_hour=13, tm_min=28, tm_sec=47, tm_wday=1, tm_yday=46, tm_isdst=0) with schedule_value 10 2011-02-15 13:28:47,623 Trac[scheduler] DEBUG: task [mytask] is scheduled for 15 2011-02-15 13:28:47,623 Trac[scheduler] DEBUG: hourly compare currentTime=time.struct_time(tm_year=2011, tm_mon=2, tm_mday=15, tm_hour=13, tm_min=28, tm_sec=47, tm_wday=1, tm_yday=46, tm_isdst=0) with schedule_value 15 2011-02-15 13:28:47,623 Trac[scheduler] DEBUG: task [mytask] is scheduled for 20 2011-02-15 13:28:47,623 Trac[scheduler] DEBUG: hourly compare currentTime=time.struct_time(tm_year=2011, tm_mon=2, tm_mday=15, tm_hour=13, tm_min=28, tm_sec=47, tm_wday=1, tm_yday=46, tm_isdst=0) with schedule_value 20 2011-02-15 13:28:47,624 Trac[scheduler] DEBUG: task [mytask] is scheduled for 25 2011-02-15 13:28:47,624 Trac[scheduler] DEBUG: hourly compare currentTime=time.struct_time(tm_year=2011, tm_mon=2, tm_mday=15, tm_hour=13, tm_min=28, tm_sec=47, tm_wday=1, tm_yday=46, tm_isdst=0) with schedule_value 25 2011-02-15 13:28:47,624 Trac[scheduler] DEBUG: task [mytask] is scheduled for 30 2011-02-15 13:28:47,624 Trac[scheduler] DEBUG: hourly compare currentTime=time.struct_time(tm_year=2011, tm_mon=2, tm_mday=15, tm_hour=13, tm_min=28, tm_sec=47, tm_wday=1, tm_yday=46, tm_isdst=0) with schedule_value 30 2011-02-15 13:28:47,624 Trac[scheduler] DEBUG: task [mytask] is scheduled for 35 2011-02-15 13:28:47,625 Trac[scheduler] DEBUG: hourly compare currentTime=time.struct_time(tm_year=2011, tm_mon=2, tm_mday=15, tm_hour=13, tm_min=28, tm_sec=47, tm_wday=1, tm_yday=46, tm_isdst=0) with schedule_value 35 2011-02-15 13:28:47,625 Trac[scheduler] DEBUG: task [mytask] is scheduled for 40 2011-02-15 13:28:47,625 Trac[scheduler] DEBUG: hourly compare currentTime=time.struct_time(tm_year=2011, tm_mon=2, tm_mday=15, tm_hour=13, tm_min=28, tm_sec=47, tm_wday=1, tm_yday=46, tm_isdst=0) with schedule_value 40 2011-02-15 13:28:47,625 Trac[scheduler] DEBUG: task [mytask] is scheduled for 45 2011-02-15 13:28:47,625 Trac[scheduler] DEBUG: hourly compare currentTime=time.struct_time(tm_year=2011, tm_mon=2, tm_mday=15, tm_hour=13, tm_min=28, tm_sec=47, tm_wday=1, tm_yday=46, tm_isdst=0) with schedule_value 45 2011-02-15 13:28:47,626 Trac[scheduler] DEBUG: task [mytask] is scheduled for 50 2011-02-15 13:28:47,626 Trac[scheduler] DEBUG: hourly compare currentTime=time.struct_time(tm_year=2011, tm_mon=2, tm_mday=15, tm_hour=13, tm_min=28, tm_sec=47, tm_wday=1, tm_yday=46, tm_isdst=0) with schedule_value 50 2011-02-15 13:28:47,626 Trac[scheduler] DEBUG: task [mytask] is scheduled for 55 2011-02-15 13:28:47,626 Trac[scheduler] DEBUG: hourly compare currentTime=time.struct_time(tm_year=2011, tm_mon=2, tm_mday=15, tm_hour=13, tm_min=28, tm_sec=47, tm_wday=1, tm_yday=46, tm_isdst=0) with schedule_value 55 2011-02-15 13:28:47,626 Trac[scheduler] DEBUG: task [mytask] is scheduled for 0 2011-02-15 13:28:47,627 Trac[scheduler] DEBUG: hourly compare currentTime=time.struct_time(tm_year=2011, tm_mon=2, tm_mday=15, tm_hour=13, tm_min=28, tm_sec=47, tm_wday=1, tm_yday=46, tm_isdst=0) with schedule_value 0 2011-02-15 13:28:47,627 Trac[scheduler] DEBUG: no matching schedule found 2011-02-15 13:28:47,627 Trac[core] DEBUG: nothing to do for mytask 2011-02-15 13:28:47,627 Trac[core] DEBUG: schedule weekly is disabled 2011-02-15 13:28:47,627 Trac[core] DEBUG: schedule monthly is disabled 2011-02-15 13:28:47,628 Trac[core] DEBUG: schedule cron is disabled 2011-02-15 13:28:47,628 Trac[core] DEBUG: last wake up time 2011-02-15 13:28:47 2011-02-15 13:28:47,628 Trac[core] DEBUG: next wake up time 2011-02-15 13:29:47 2011-02-15 13:28:47,628 Trac[core] DEBUG: current time 2011-02-15 13:28:47 2011-02-15 13:28:47,628 Trac[core] DEBUG: adjusted wait 60 secondes 2011-02-15 13:28:47,629 Trac[core] DEBUG: create new ticker 2011-02-15 13:28:47,629 Trac[core] DEBUG: new ticker started 2011-02-15 13:28:56,569 Trac[core] DEBUG: ticker wake up 2011-02-15 13:28:56,570 Trac[core] DEBUG: check existing task 2011-02-15 13:28:56,570 Trac[core] DEBUG: check task mytask 2011-02-15 13:28:56,570 Trac[core] DEBUG: schedule daily is disabled 2011-02-15 13:28:56,570 Trac[scheduler] DEBUG: looking for schedule of type hourly 2011-02-15 13:28:56,571 Trac[scheduler] DEBUG: task [mytask] is scheduled for 5 2011-02-15 13:28:56,571 Trac[scheduler] DEBUG: hourly compare currentTime=time.struct_time(tm_year=2011, tm_mon=2, tm_mday=15, tm_hour=13, tm_min=28, tm_sec=56, tm_wday=1, tm_yday=46, tm_isdst=0) with schedule_value 5 2011-02-15 13:28:56,571 Trac[scheduler] DEBUG: task [mytask] is scheduled for 10 2011-02-15 13:28:56,571 Trac[scheduler] DEBUG: hourly compare currentTime=time.struct_time(tm_year=2011, tm_mon=2, tm_mday=15, tm_hour=13, tm_min=28, tm_sec=56, tm_wday=1, tm_yday=46, tm_isdst=0) with schedule_value 10 2011-02-15 13:28:56,572 Trac[scheduler] DEBUG: task [mytask] is scheduled for 15 2011-02-15 13:28:56,572 Trac[scheduler] DEBUG: hourly compare currentTime=time.struct_time(tm_year=2011, tm_mon=2, tm_mday=15, tm_hour=13, tm_min=28, tm_sec=56, tm_wday=1, tm_yday=46, tm_isdst=0) with schedule_value 15 2011-02-15 13:28:56,572 Trac[scheduler] DEBUG: task [mytask] is scheduled for 20 2011-02-15 13:28:56,572 Trac[scheduler] DEBUG: hourly compare currentTime=time.struct_time(tm_year=2011, tm_mon=2, tm_mday=15, tm_hour=13, tm_min=28, tm_sec=56, tm_wday=1, tm_yday=46, tm_isdst=0) with schedule_value 20 2011-02-15 13:28:56,572 Trac[scheduler] DEBUG: task [mytask] is scheduled for 25 2011-02-15 13:28:56,573 Trac[scheduler] DEBUG: hourly compare currentTime=time.struct_time(tm_year=2011, tm_mon=2, tm_mday=15, tm_hour=13, tm_min=28, tm_sec=56, tm_wday=1, tm_yday=46, tm_isdst=0) with schedule_value 25 2011-02-15 13:28:56,573 Trac[scheduler] DEBUG: task [mytask] is scheduled for 30 2011-02-15 13:28:56,573 Trac[scheduler] DEBUG: hourly compare currentTime=time.struct_time(tm_year=2011, tm_mon=2, tm_mday=15, tm_hour=13, tm_min=28, tm_sec=56, tm_wday=1, tm_yday=46, tm_isdst=0) with schedule_value 30 2011-02-15 13:28:56,573 Trac[scheduler] DEBUG: task [mytask] is scheduled for 35 2011-02-15 13:28:56,573 Trac[scheduler] DEBUG: hourly compare currentTime=time.struct_time(tm_year=2011, tm_mon=2, tm_mday=15, tm_hour=13, tm_min=28, tm_sec=56, tm_wday=1, tm_yday=46, tm_isdst=0) with schedule_value 35 2011-02-15 13:28:56,574 Trac[scheduler] DEBUG: task [mytask] is scheduled for 40 2011-02-15 13:28:56,574 Trac[scheduler] DEBUG: hourly compare currentTime=time.struct_time(tm_year=2011, tm_mon=2, tm_mday=15, tm_hour=13, tm_min=28, tm_sec=56, tm_wday=1, tm_yday=46, tm_isdst=0) with schedule_value 40 2011-02-15 13:28:56,574 Trac[scheduler] DEBUG: task [mytask] is scheduled for 45 2011-02-15 13:28:56,574 Trac[scheduler] DEBUG: hourly compare currentTime=time.struct_time(tm_year=2011, tm_mon=2, tm_mday=15, tm_hour=13, tm_min=28, tm_sec=56, tm_wday=1, tm_yday=46, tm_isdst=0) with schedule_value 45 2011-02-15 13:28:56,574 Trac[scheduler] DEBUG: task [mytask] is scheduled for 50 2011-02-15 13:28:56,575 Trac[scheduler] DEBUG: hourly compare currentTime=time.struct_time(tm_year=2011, tm_mon=2, tm_mday=15, tm_hour=13, tm_min=28, tm_sec=56, tm_wday=1, tm_yday=46, tm_isdst=0) with schedule_value 50 2011-02-15 13:28:56,575 Trac[scheduler] DEBUG: task [mytask] is scheduled for 55 2011-02-15 13:28:56,575 Trac[scheduler] DEBUG: hourly compare currentTime=time.struct_time(tm_year=2011, tm_mon=2, tm_mday=15, tm_hour=13, tm_min=28, tm_sec=56, tm_wday=1, tm_yday=46, tm_isdst=0) with schedule_value 55 2011-02-15 13:28:56,575 Trac[scheduler] DEBUG: task [mytask] is scheduled for 0 2011-02-15 13:28:56,575 Trac[scheduler] DEBUG: hourly compare currentTime=time.struct_time(tm_year=2011, tm_mon=2, tm_mday=15, tm_hour=13, tm_min=28, tm_sec=56, tm_wday=1, tm_yday=46, tm_isdst=0) with schedule_value 0 2011-02-15 13:28:56,576 Trac[scheduler] DEBUG: no matching schedule found 2011-02-15 13:28:56,576 Trac[core] DEBUG: nothing to do for mytask 2011-02-15 13:28:56,576 Trac[core] DEBUG: schedule weekly is disabled 2011-02-15 13:28:56,576 Trac[core] DEBUG: schedule monthly is disabled 2011-02-15 13:28:56,576 Trac[core] DEBUG: schedule cron is disabled 2011-02-15 13:28:56,577 Trac[core] DEBUG: last wake up time 2011-02-15 13:28:56 2011-02-15 13:28:56,577 Trac[core] DEBUG: next wake up time 2011-02-15 13:29:56 2011-02-15 13:28:56,577 Trac[core] DEBUG: current time 2011-02-15 13:28:56 2011-02-15 13:28:56,577 Trac[core] DEBUG: adjusted wait 60 secondes 2011-02-15 13:28:56,577 Trac[core] DEBUG: create new ticker 2011-02-15 13:28:56,578 Trac[core] DEBUG: new ticker started 2011-02-15 13:28:56,867 Trac[core] DEBUG: ticker wake up 2011-02-15 13:28:56,868 Trac[core] DEBUG: check existing task 2011-02-15 13:28:56,868 Trac[core] DEBUG: check task mytask 2011-02-15 13:28:56,868 Trac[core] DEBUG: schedule daily is disabled 2011-02-15 13:28:56,868 Trac[scheduler] DEBUG: looking for schedule of type hourly 2011-02-15 13:28:56,869 Trac[scheduler] DEBUG: task [mytask] is scheduled for 5 2011-02-15 13:28:56,869 Trac[scheduler] DEBUG: hourly compare currentTime=time.struct_time(tm_year=2011, tm_mon=2, tm_mday=15, tm_hour=13, tm_min=28, tm_sec=56, tm_wday=1, tm_yday=46, tm_isdst=0) with schedule_value 5 2011-02-15 13:28:56,869 Trac[scheduler] DEBUG: task [mytask] is scheduled for 10 2011-02-15 13:28:56,869 Trac[scheduler] DEBUG: hourly compare currentTime=time.struct_time(tm_year=2011, tm_mon=2, tm_mday=15, tm_hour=13, tm_min=28, tm_sec=56, tm_wday=1, tm_yday=46, tm_isdst=0) with schedule_value 10 2011-02-15 13:28:56,869 Trac[scheduler] DEBUG: task [mytask] is scheduled for 15 2011-02-15 13:28:56,870 Trac[scheduler] DEBUG: hourly compare currentTime=time.struct_time(tm_year=2011, tm_mon=2, tm_mday=15, tm_hour=13, tm_min=28, tm_sec=56, tm_wday=1, tm_yday=46, tm_isdst=0) with schedule_value 15 2011-02-15 13:28:56,870 Trac[scheduler] DEBUG: task [mytask] is scheduled for 20 2011-02-15 13:28:56,870 Trac[scheduler] DEBUG: hourly compare currentTime=time.struct_time(tm_year=2011, tm_mon=2, tm_mday=15, tm_hour=13, tm_min=28, tm_sec=56, tm_wday=1, tm_yday=46, tm_isdst=0) with schedule_value 20 2011-02-15 13:28:56,870 Trac[scheduler] DEBUG: task [mytask] is scheduled for 25 2011-02-15 13:28:56,870 Trac[scheduler] DEBUG: hourly compare currentTime=time.struct_time(tm_year=2011, tm_mon=2, tm_mday=15, tm_hour=13, tm_min=28, tm_sec=56, tm_wday=1, tm_yday=46, tm_isdst=0) with schedule_value 25 2011-02-15 13:28:56,871 Trac[scheduler] DEBUG: task [mytask] is scheduled for 30 2011-02-15 13:28:56,871 Trac[scheduler] DEBUG: hourly compare currentTime=time.struct_time(tm_year=2011, tm_mon=2, tm_mday=15, tm_hour=13, tm_min=28, tm_sec=56, tm_wday=1, tm_yday=46, tm_isdst=0) with schedule_value 30 2011-02-15 13:28:56,871 Trac[scheduler] DEBUG: task [mytask] is scheduled for 35 2011-02-15 13:28:56,871 Trac[scheduler] DEBUG: hourly compare currentTime=time.struct_time(tm_year=2011, tm_mon=2, tm_mday=15, tm_hour=13, tm_min=28, tm_sec=56, tm_wday=1, tm_yday=46, tm_isdst=0) with schedule_value 35 2011-02-15 13:28:56,871 Trac[scheduler] DEBUG: task [mytask] is scheduled for 40 2011-02-15 13:28:56,872 Trac[scheduler] DEBUG: hourly compare currentTime=time.struct_time(tm_year=2011, tm_mon=2, tm_mday=15, tm_hour=13, tm_min=28, tm_sec=56, tm_wday=1, tm_yday=46, tm_isdst=0) with schedule_value 40 2011-02-15 13:28:56,872 Trac[scheduler] DEBUG: task [mytask] is scheduled for 45 2011-02-15 13:28:56,872 Trac[scheduler] DEBUG: hourly compare currentTime=time.struct_time(tm_year=2011, tm_mon=2, tm_mday=15, tm_hour=13, tm_min=28, tm_sec=56, tm_wday=1, tm_yday=46, tm_isdst=0) with schedule_value 45 2011-02-15 13:28:56,872 Trac[scheduler] DEBUG: task [mytask] is scheduled for 50 2011-02-15 13:28:56,872 Trac[scheduler] DEBUG: hourly compare currentTime=time.struct_time(tm_year=2011, tm_mon=2, tm_mday=15, tm_hour=13, tm_min=28, tm_sec=56, tm_wday=1, tm_yday=46, tm_isdst=0) with schedule_value 50 2011-02-15 13:28:56,873 Trac[scheduler] DEBUG: task [mytask] is scheduled for 55 2011-02-15 13:28:56,873 Trac[scheduler] DEBUG: hourly compare currentTime=time.struct_time(tm_year=2011, tm_mon=2, tm_mday=15, tm_hour=13, tm_min=28, tm_sec=56, tm_wday=1, tm_yday=46, tm_isdst=0) with schedule_value 55 2011-02-15 13:28:56,873 Trac[scheduler] DEBUG: task [mytask] is scheduled for 0 2011-02-15 13:28:56,873 Trac[scheduler] DEBUG: hourly compare currentTime=time.struct_time(tm_year=2011, tm_mon=2, tm_mday=15, tm_hour=13, tm_min=28, tm_sec=56, tm_wday=1, tm_yday=46, tm_isdst=0) with schedule_value 0 2011-02-15 13:28:56,873 Trac[scheduler] DEBUG: no matching schedule found 2011-02-15 13:28:56,874 Trac[core] DEBUG: nothing to do for mytask 2011-02-15 13:28:56,874 Trac[core] DEBUG: schedule weekly is disabled 2011-02-15 13:28:56,874 Trac[core] DEBUG: schedule monthly is disabled 2011-02-15 13:28:56,874 Trac[core] DEBUG: schedule cron is disabled 2011-02-15 13:28:56,874 Trac[core] DEBUG: last wake up time 2011-02-15 13:28:56 2011-02-15 13:28:56,875 Trac[core] DEBUG: next wake up time 2011-02-15 13:29:56 2011-02-15 13:28:56,875 Trac[core] DEBUG: current time 2011-02-15 13:28:56 2011-02-15 13:28:56,875 Trac[core] DEBUG: adjusted wait 60 secondes 2011-02-15 13:28:56,875 Trac[core] DEBUG: create new ticker 2011-02-15 13:28:56,876 Trac[core] DEBUG: new ticker started 2011-02-15 13:28:56,899 Trac[core] DEBUG: ticker wake up 2011-02-15 13:28:56,900 Trac[core] DEBUG: check existing task 2011-02-15 13:28:56,900 Trac[core] DEBUG: check task mytask 2011-02-15 13:28:56,900 Trac[core] DEBUG: schedule daily is disabled 2011-02-15 13:28:56,900 Trac[scheduler] DEBUG: looking for schedule of type hourly 2011-02-15 13:28:56,901 Trac[scheduler] DEBUG: task [mytask] is scheduled for 5 2011-02-15 13:28:56,901 Trac[scheduler] DEBUG: hourly compare currentTime=time.struct_time(tm_year=2011, tm_mon=2, tm_mday=15, tm_hour=13, tm_min=28, tm_sec=56, tm_wday=1, tm_yday=46, tm_isdst=0) with schedule_value 5 2011-02-15 13:28:56,901 Trac[scheduler] DEBUG: task [mytask] is scheduled for 10 2011-02-15 13:28:56,901 Trac[scheduler] DEBUG: hourly compare currentTime=time.struct_time(tm_year=2011, tm_mon=2, tm_mday=15, tm_hour=13, tm_min=28, tm_sec=56, tm_wday=1, tm_yday=46, tm_isdst=0) with schedule_value 10 2011-02-15 13:28:56,901 Trac[scheduler] DEBUG: task [mytask] is scheduled for 15 2011-02-15 13:28:56,902 Trac[scheduler] DEBUG: hourly compare currentTime=time.struct_time(tm_year=2011, tm_mon=2, tm_mday=15, tm_hour=13, tm_min=28, tm_sec=56, tm_wday=1, tm_yday=46, tm_isdst=0) with schedule_value 15 2011-02-15 13:28:56,902 Trac[scheduler] DEBUG: task [mytask] is scheduled for 20 2011-02-15 13:28:56,902 Trac[scheduler] DEBUG: hourly compare currentTime=time.struct_time(tm_year=2011, tm_mon=2, tm_mday=15, tm_hour=13, tm_min=28, tm_sec=56, tm_wday=1, tm_yday=46, tm_isdst=0) with schedule_value 20 2011-02-15 13:28:56,902 Trac[scheduler] DEBUG: task [mytask] is scheduled for 25 2011-02-15 13:28:56,902 Trac[scheduler] DEBUG: hourly compare currentTime=time.struct_time(tm_year=2011, tm_mon=2, tm_mday=15, tm_hour=13, tm_min=28, tm_sec=56, tm_wday=1, tm_yday=46, tm_isdst=0) with schedule_value 25 2011-02-15 13:28:56,903 Trac[scheduler] DEBUG: task [mytask] is scheduled for 30 2011-02-15 13:28:56,903 Trac[scheduler] DEBUG: hourly compare currentTime=time.struct_time(tm_year=2011, tm_mon=2, tm_mday=15, tm_hour=13, tm_min=28, tm_sec=56, tm_wday=1, tm_yday=46, tm_isdst=0) with schedule_value 30 2011-02-15 13:28:56,903 Trac[scheduler] DEBUG: task [mytask] is scheduled for 35 2011-02-15 13:28:56,903 Trac[scheduler] DEBUG: hourly compare currentTime=time.struct_time(tm_year=2011, tm_mon=2, tm_mday=15, tm_hour=13, tm_min=28, tm_sec=56, tm_wday=1, tm_yday=46, tm_isdst=0) with schedule_value 35 2011-02-15 13:28:56,903 Trac[scheduler] DEBUG: task [mytask] is scheduled for 40 2011-02-15 13:28:56,904 Trac[scheduler] DEBUG: hourly compare currentTime=time.struct_time(tm_year=2011, tm_mon=2, tm_mday=15, tm_hour=13, tm_min=28, tm_sec=56, tm_wday=1, tm_yday=46, tm_isdst=0) with schedule_value 40 2011-02-15 13:28:56,904 Trac[scheduler] DEBUG: task [mytask] is scheduled for 45 2011-02-15 13:28:56,904 Trac[scheduler] DEBUG: hourly compare currentTime=time.struct_time(tm_year=2011, tm_mon=2, tm_mday=15, tm_hour=13, tm_min=28, tm_sec=56, tm_wday=1, tm_yday=46, tm_isdst=0) with schedule_value 45 2011-02-15 13:28:56,904 Trac[scheduler] DEBUG: task [mytask] is scheduled for 50 2011-02-15 13:28:56,904 Trac[scheduler] DEBUG: hourly compare currentTime=time.struct_time(tm_year=2011, tm_mon=2, tm_mday=15, tm_hour=13, tm_min=28, tm_sec=56, tm_wday=1, tm_yday=46, tm_isdst=0) with schedule_value 50 2011-02-15 13:28:56,905 Trac[scheduler] DEBUG: task [mytask] is scheduled for 55 2011-02-15 13:28:56,905 Trac[scheduler] DEBUG: hourly compare currentTime=time.struct_time(tm_year=2011, tm_mon=2, tm_mday=15, tm_hour=13, tm_min=28, tm_sec=56, tm_wday=1, tm_yday=46, tm_isdst=0) with schedule_value 55 2011-02-15 13:28:56,905 Trac[scheduler] DEBUG: task [mytask] is scheduled for 0 2011-02-15 13:28:56,905 Trac[scheduler] DEBUG: hourly compare currentTime=time.struct_time(tm_year=2011, tm_mon=2, tm_mday=15, tm_hour=13, tm_min=28, tm_sec=56, tm_wday=1, tm_yday=46, tm_isdst=0) with schedule_value 0 2011-02-15 13:28:56,905 Trac[scheduler] DEBUG: no matching schedule found 2011-02-15 13:28:56,905 Trac[core] DEBUG: nothing to do for mytask 2011-02-15 13:28:56,906 Trac[core] DEBUG: schedule weekly is disabled 2011-02-15 13:28:56,906 Trac[core] DEBUG: schedule monthly is disabled 2011-02-15 13:28:56,906 Trac[core] DEBUG: schedule cron is disabled 2011-02-15 13:28:56,906 Trac[core] DEBUG: last wake up time 2011-02-15 13:28:56 2011-02-15 13:28:56,907 Trac[core] DEBUG: next wake up time 2011-02-15 13:29:56 2011-02-15 13:28:56,907 Trac[core] DEBUG: current time 2011-02-15 13:28:56 2011-02-15 13:28:56,907 Trac[core] DEBUG: adjusted wait 60 secondes 2011-02-15 13:28:56,907 Trac[core] DEBUG: create new ticker 2011-02-15 13:28:56,908 Trac[core] DEBUG: new ticker started 2011-02-15 13:28:56,918 Trac[core] DEBUG: ticker wake up 2011-02-15 13:28:56,919 Trac[core] DEBUG: check existing task 2011-02-15 13:28:56,919 Trac[core] DEBUG: check task mytask 2011-02-15 13:28:56,919 Trac[core] DEBUG: schedule daily is disabled 2011-02-15 13:28:56,919 Trac[scheduler] DEBUG: looking for schedule of type hourly 2011-02-15 13:28:56,920 Trac[scheduler] DEBUG: task [mytask] is scheduled for 5 2011-02-15 13:28:56,920 Trac[scheduler] DEBUG: hourly compare currentTime=time.struct_time(tm_year=2011, tm_mon=2, tm_mday=15, tm_hour=13, tm_min=28, tm_sec=56, tm_wday=1, tm_yday=46, tm_isdst=0) with schedule_value 5 2011-02-15 13:28:56,920 Trac[scheduler] DEBUG: task [mytask] is scheduled for 10 2011-02-15 13:28:56,920 Trac[scheduler] DEBUG: hourly compare currentTime=time.struct_time(tm_year=2011, tm_mon=2, tm_mday=15, tm_hour=13, tm_min=28, tm_sec=56, tm_wday=1, tm_yday=46, tm_isdst=0) with schedule_value 10 2011-02-15 13:28:56,920 Trac[scheduler] DEBUG: task [mytask] is scheduled for 15 2011-02-15 13:28:56,921 Trac[scheduler] DEBUG: hourly compare currentTime=time.struct_time(tm_year=2011, tm_mon=2, tm_mday=15, tm_hour=13, tm_min=28, tm_sec=56, tm_wday=1, tm_yday=46, tm_isdst=0) with schedule_value 15 2011-02-15 13:28:56,921 Trac[scheduler] DEBUG: task [mytask] is scheduled for 20 2011-02-15 13:28:56,921 Trac[scheduler] DEBUG: hourly compare currentTime=time.struct_time(tm_year=2011, tm_mon=2, tm_mday=15, tm_hour=13, tm_min=28, tm_sec=56, tm_wday=1, tm_yday=46, tm_isdst=0) with schedule_value 20 2011-02-15 13:28:56,921 Trac[scheduler] DEBUG: task [mytask] is scheduled for 25 2011-02-15 13:28:56,921 Trac[scheduler] DEBUG: hourly compare currentTime=time.struct_time(tm_year=2011, tm_mon=2, tm_mday=15, tm_hour=13, tm_min=28, tm_sec=56, tm_wday=1, tm_yday=46, tm_isdst=0) with schedule_value 25 2011-02-15 13:28:56,922 Trac[scheduler] DEBUG: task [mytask] is scheduled for 30 2011-02-15 13:28:56,922 Trac[scheduler] DEBUG: hourly compare currentTime=time.struct_time(tm_year=2011, tm_mon=2, tm_mday=15, tm_hour=13, tm_min=28, tm_sec=56, tm_wday=1, tm_yday=46, tm_isdst=0) with schedule_value 30 2011-02-15 13:28:56,922 Trac[scheduler] DEBUG: task [mytask] is scheduled for 35 2011-02-15 13:28:56,922 Trac[scheduler] DEBUG: hourly compare currentTime=time.struct_time(tm_year=2011, tm_mon=2, tm_mday=15, tm_hour=13, tm_min=28, tm_sec=56, tm_wday=1, tm_yday=46, tm_isdst=0) with schedule_value 35 2011-02-15 13:28:56,922 Trac[scheduler] DEBUG: task [mytask] is scheduled for 40 2011-02-15 13:28:56,923 Trac[scheduler] DEBUG: hourly compare currentTime=time.struct_time(tm_year=2011, tm_mon=2, tm_mday=15, tm_hour=13, tm_min=28, tm_sec=56, tm_wday=1, tm_yday=46, tm_isdst=0) with schedule_value 40 2011-02-15 13:28:56,923 Trac[scheduler] DEBUG: task [mytask] is scheduled for 45 2011-02-15 13:28:56,923 Trac[scheduler] DEBUG: hourly compare currentTime=time.struct_time(tm_year=2011, tm_mon=2, tm_mday=15, tm_hour=13, tm_min=28, tm_sec=56, tm_wday=1, tm_yday=46, tm_isdst=0) with schedule_value 45 2011-02-15 13:28:56,923 Trac[scheduler] DEBUG: task [mytask] is scheduled for 50 2011-02-15 13:28:56,923 Trac[scheduler] DEBUG: hourly compare currentTime=time.struct_time(tm_year=2011, tm_mon=2, tm_mday=15, tm_hour=13, tm_min=28, tm_sec=56, tm_wday=1, tm_yday=46, tm_isdst=0) with schedule_value 50 2011-02-15 13:28:56,924 Trac[scheduler] DEBUG: task [mytask] is scheduled for 55 2011-02-15 13:28:56,924 Trac[scheduler] DEBUG: hourly compare currentTime=time.struct_time(tm_year=2011, tm_mon=2, tm_mday=15, tm_hour=13, tm_min=28, tm_sec=56, tm_wday=1, tm_yday=46, tm_isdst=0) with schedule_value 55 2011-02-15 13:28:56,924 Trac[scheduler] DEBUG: task [mytask] is scheduled for 0 2011-02-15 13:28:56,924 Trac[scheduler] DEBUG: hourly compare currentTime=time.struct_time(tm_year=2011, tm_mon=2, tm_mday=15, tm_hour=13, tm_min=28, tm_sec=56, tm_wday=1, tm_yday=46, tm_isdst=0) with schedule_value 0 2011-02-15 13:28:56,924 Trac[scheduler] DEBUG: no matching schedule found 2011-02-15 13:28:56,925 Trac[core] DEBUG: nothing to do for mytask 2011-02-15 13:28:56,925 Trac[core] DEBUG: schedule weekly is disabled 2011-02-15 13:28:56,925 Trac[core] DEBUG: schedule monthly is disabled 2011-02-15 13:28:56,925 Trac[core] DEBUG: schedule cron is disabled 2011-02-15 13:28:56,925 Trac[core] DEBUG: last wake up time 2011-02-15 13:28:56 2011-02-15 13:28:56,926 Trac[core] DEBUG: next wake up time 2011-02-15 13:29:56 2011-02-15 13:28:56,926 Trac[core] DEBUG: current time 2011-02-15 13:28:56 2011-02-15 13:28:56,926 Trac[core] DEBUG: adjusted wait 60 secondes 2011-02-15 13:28:56,926 Trac[core] DEBUG: create new ticker 2011-02-15 13:28:56,927 Trac[core] DEBUG: new ticker started