{"action":"created","issue":{"url":"https://api.github.com/repos/intelsdi-x/snap/issues/1575","repository_url":"https://api.github.com/repos/intelsdi-x/snap","labels_url":"https://api.github.com/repos/intelsdi-x/snap/issues/1575/labels{/name}","comments_url":"https://api.github.com/repos/intelsdi-x/snap/issues/1575/comments","events_url":"https://api.github.com/repos/intelsdi-x/snap/issues/1575/events","html_url":"https://github.com/intelsdi-x/snap/issues/1575","id":217524168,"number":1575,"title":"Random large delays between task runs","user":{"login":"daledude","id":590325,"avatar_url":"https://avatars1.githubusercontent.com/u/590325?v=3","gravatar_id":"","url":"https://api.github.com/users/daledude","html_url":"https://github.com/daledude","followers_url":"https://api.github.com/users/daledude/followers","following_url":"https://api.github.com/users/daledude/following{/other_user}","gists_url":"https://api.github.com/users/daledude/gists{/gist_id}","starred_url":"https://api.github.com/users/daledude/starred{/owner}{/repo}","subscriptions_url":"https://api.github.com/users/daledude/subscriptions","organizations_url":"https://api.github.com/users/daledude/orgs","repos_url":"https://api.github.com/users/daledude/repos","events_url":"https://api.github.com/users/daledude/events{/privacy}","received_events_url":"https://api.github.com/users/daledude/received_events","type":"User","site_admin":false},"labels":[{"id":410260025,"url":"https://api.github.com/repos/intelsdi-x/snap/labels/area/logging","name":"area/logging","color":"bfdadc","default":false}],"state":"open","locked":false,"assignee":null,"assignees":[],"milestone":null,"comments":7,"created_at":"2017-03-28T11:07:48Z","updated_at":"2017-03-29T08:37:51Z","closed_at":null,"body":"I have 4 tasks (dbi, processes, procstat, psutil) that are configured to run every 60 seconds. I'm using the default config given within redhat rpm. snap version 1.2 on kernel 2.6.18-238.9.1.el5. Below is a clip of the snap log where it shows nothing run between 03:43 and 03:48.\r\n\r\n\r\n```\r\ntime=\"2017-03-28T03:42:57-07:00\" level=debug msg=\"Ping received\" _module=plugin-exec io=stderr plugin=influxdb \r\ntime=\"2017-03-28T03:43:02-07:00\" level=debug msg=\"Ping received\" _module=plugin-exec io=stderr plugin=influxdb \r\ntime=\"2017-03-28T03:43:02-07:00\" level=debug msg=\"Ping received\" _module=plugin-exec io=stderr plugin=processes \r\ntime=\"2017-03-28T03:43:02-07:00\" level=debug msg=\"Ping received\" _module=plugin-exec io=stderr plugin=procstat \r\ntime=\"2017-03-28T03:43:02-07:00\" level=debug msg=\"Ping received\" _module=plugin-exec io=stderr plugin=influxdb \r\ntime=\"2017-03-28T03:43:02-07:00\" level=debug msg=\"Ping received\" _module=plugin-exec io=stderr plugin=psutil \r\ntime=\"2017-03-28T03:43:02-07:00\" level=debug msg=\"Ping received\" _module=plugin-exec io=stderr plugin=influxdb \r\ntime=\"2017-03-28T03:43:07-07:00\" level=debug msg=\"Ping received\" _module=plugin-exec io=stderr plugin=processes \r\ntime=\"2017-03-28T03:43:07-07:00\" level=debug msg=\"Ping received\" _module=plugin-exec io=stderr plugin=influxdb \r\ntime=\"2017-03-28T03:43:07-07:00\" level=debug msg=\"Ping received\" _module=plugin-exec io=stderr plugin=procstat \r\ntime=\"2017-03-28T03:43:07-07:00\" level=debug msg=\"Ping received\" _module=plugin-exec io=stderr plugin=psutil \r\ntime=\"2017-03-28T03:43:07-07:00\" level=debug msg=\"Ping received\" _module=plugin-exec io=stderr plugin=influxdb \r\ntime=\"2017-03-28T03:43:07-07:00\" level=debug msg=\"Ping received\" _module=plugin-exec io=stderr plugin=influxdb \r\ntime=\"2017-03-28T03:48:09-07:00\" level=debug msg=\"Starting workflow\" _block=workflow-start _module=scheduler-workflow task-id=61688ecc-772f-43c1-a892-19b3509e9c30 task-name=psutil \r\ntime=\"2017-03-28T03:48:09-07:00\" level=debug msg=\"starting collector job\" _module=scheduler-job block=run job-type=collector metric-count=17 \r\ntime=\"2017-03-28T03:48:09-07:00\" level=debug msg=\"Starting workflow\" _block=workflow-start _module=scheduler-workflow task-id=adab00b0-4414-47be-bc8e-3265f5aa117d task-name=processes \r\ntime=\"2017-03-28T03:48:09-07:00\" level=debug msg=\"starting collector job\" _module=scheduler-job block=run job-type=collector metric-count=3 \r\ntime=\"2017-03-28T03:48:09-07:00\" level=debug msg=\"Starting workflow\" _block=workflow-start _module=scheduler-workflow task-id=ef29afd8-f2e8-4787-a9b8-69a7dc2be3c5 task-name=procstat \r\ntime=\"2017-03-28T03:48:09-07:00\" level=debug msg=\"starting collector job\" _module=scheduler-job block=run job-type=collector metric-count=1 \r\ntime=\"2017-03-28T03:48:09-07:00\" level=debug msg=\"Starting workflow\" _block=workflow-start _module=scheduler-workflow task-id=89ceea6c-78c7-4fe0-bf05-fcc0997b66fd task-name=dbi \r\ntime=\"2017-03-28T03:48:09-07:00\" level=debug msg=\"starting collector job\" _module=scheduler-job block=run job-type=collector metric-count=8 \r\ntime=\"2017-03-28T03:48:09-07:00\" level=debug msg=\"cache miss [/intel/psutil/vm/buffers:9]\" _module=routing-cache hits=0 misses=253 namespace=\"/intel/psutil/vm/buffers:9\" \r\ntime=\"2017-03-28T03:48:09-07:00\" level=debug msg=\"cache miss [/intel/psutil/vm/total:9]\" _module=routing-cache hits=0 misses=253 namespace=\"/intel/psutil/vm/total:9\" \r\ntime=\"2017-03-28T03:48:09-07:00\" level=debug msg=\"cache miss [/intel/psutil/vm/used:9]\" _module=routing-cache hits=0 misses=253 namespace=\"/intel/psutil/vm/used:9\" \r\ntime=\"2017-03-28T03:48:09-07:00\" level=debug msg=\"cache miss [/intel/psutil/cpu/cpu-total/softirq:9]\" _module=routing-cache hits=0 misses=253 namespace=\"/intel/psutil/cpu/cpu-total/softirq:9\" \r\ntime=\"2017-03-28T03:48:09-07:00\" level=debug msg=\"cache miss [/intel/psutil/cpu/cpu-total/user:9]\" _module=routing-cache hits=0 misses=253 namespace=\"/intel/psutil/cpu/cpu-total/user:9\" \r\n\r\n```\r\n\r\n"},"comment":{"url":"https://api.github.com/repos/intelsdi-x/snap/issues/comments/290022507","html_url":"https://github.com/intelsdi-x/snap/issues/1575#issuecomment-290022507","issue_url":"https://api.github.com/repos/intelsdi-x/snap/issues/1575","id":290022507,"user":{"login":"mkuculyma","id":6523391,"avatar_url":"https://avatars3.githubusercontent.com/u/6523391?v=3","gravatar_id":"","url":"https://api.github.com/users/mkuculyma","html_url":"https://github.com/mkuculyma","followers_url":"https://api.github.com/users/mkuculyma/followers","following_url":"https://api.github.com/users/mkuculyma/following{/other_user}","gists_url":"https://api.github.com/users/mkuculyma/gists{/gist_id}","starred_url":"https://api.github.com/users/mkuculyma/starred{/owner}{/repo}","subscriptions_url":"https://api.github.com/users/mkuculyma/subscriptions","organizations_url":"https://api.github.com/users/mkuculyma/orgs","repos_url":"https://api.github.com/users/mkuculyma/repos","events_url":"https://api.github.com/users/mkuculyma/events{/privacy}","received_events_url":"https://api.github.com/users/mkuculyma/received_events","type":"User","site_admin":false},"created_at":"2017-03-29T08:37:51Z","updated_at":"2017-03-29T08:37:51Z","body":"@daledude could you please let us know if you are still experiencing this issue after kernel upgrade? 🐢  "}}
{"actor":{"display_login":"mkuculyma"}}