{"action":"created","issue":{"url":"https://api.github.com/repos/mirage/irmin/issues/198","labels_url":"https://api.github.com/repos/mirage/irmin/issues/198/labels{/name}","comments_url":"https://api.github.com/repos/mirage/irmin/issues/198/comments","events_url":"https://api.github.com/repos/mirage/irmin/issues/198/events","html_url":"https://github.com/mirage/irmin/issues/198","id":71529879,"number":198,"title":"small race in the HTTP watch init code","user":{"login":"samoht","id":103693,"avatar_url":"https://avatars.githubusercontent.com/u/103693?v=3","gravatar_id":"","url":"https://api.github.com/users/samoht","html_url":"https://github.com/samoht","followers_url":"https://api.github.com/users/samoht/followers","following_url":"https://api.github.com/users/samoht/following{/other_user}","gists_url":"https://api.github.com/users/samoht/gists{/gist_id}","starred_url":"https://api.github.com/users/samoht/starred{/owner}{/repo}","subscriptions_url":"https://api.github.com/users/samoht/subscriptions","organizations_url":"https://api.github.com/users/samoht/orgs","repos_url":"https://api.github.com/users/samoht/repos","events_url":"https://api.github.com/users/samoht/events{/privacy}","received_events_url":"https://api.github.com/users/samoht/received_events","type":"User","site_admin":false},"labels":[{"url":"https://api.github.com/repos/mirage/irmin/labels/bug","name":"bug","color":"fc2929"}],"state":"open","locked":false,"assignee":null,"milestone":null,"comments":5,"created_at":"2015-04-28T09:05:20Z","updated_at":"2015-06-19T14:47:43Z","closed_at":null,"body":"This is sometimes triggered if you run `./test.native test HTTP.MEM 4 --verbose &> l` in a loop."},"comment":{"url":"https://api.github.com/repos/mirage/irmin/issues/comments/113535981","html_url":"https://github.com/mirage/irmin/issues/198#issuecomment-113535981","issue_url":"https://api.github.com/repos/mirage/irmin/issues/198","id":113535981,"user":{"login":"samoht","id":103693,"avatar_url":"https://avatars.githubusercontent.com/u/103693?v=3","gravatar_id":"","url":"https://api.github.com/users/samoht","html_url":"https://github.com/samoht","followers_url":"https://api.github.com/users/samoht/followers","following_url":"https://api.github.com/users/samoht/following{/other_user}","gists_url":"https://api.github.com/users/samoht/gists{/gist_id}","starred_url":"https://api.github.com/users/samoht/starred{/owner}{/repo}","subscriptions_url":"https://api.github.com/users/samoht/subscriptions","organizations_url":"https://api.github.com/users/samoht/orgs","repos_url":"https://api.github.com/users/samoht/repos","events_url":"https://api.github.com/users/samoht/events{/privacy}","received_events_url":"https://api.github.com/users/samoht/received_events","type":"User","site_admin":false},"created_at":"2015-06-19T14:47:43Z","updated_at":"2015-06-19T14:47:43Z","body":"Can definitely reproduce with the test loop described in the first post:\r\n\r\n```\r\n2015-06-19 15:35:06.413 HTTP         DEBUG: post /tag/watch {\"task\":{\"date\":\"1434724506\",\"uid\":\"661\",\"owner\":\"Irmin piana.mac.cl.cam.ac.uk.[..\r\n2015-06-19 15:35:06.413 WATCH        DEBUG: watch [6: 0k/0g]: id=50\r\n--------------------------------------------------------------------------------\r\n2015-06-19 15:35:06.413              INFO : ASSERT workers: [pre-condition] watch-tag add 0:true x=0/0/0:1/0 s=0/0/0:0/0 0/0 (0, 0.000s)\r\n--------------------------------------------------------------------------------\r\n--------------------------------------------------------------------------------\r\n2015-06-19 15:35:06.413              INFO : ASSERT state: [pre-condition] watch-tag add 0:true x=0/0/0:1/0 s=0/0/0:0/0 (0, 0.000s)\r\n--------------------------------------------------------------------------------\r\n2015-06-19 15:35:06.413              DEBUG: [waiting for]  watch-tag add 0:true x=1/0/0:1/1 s=0/0/0:0/0\r\n2015-06-19 15:35:06.413 HTTP         DEBUG: post /tag/update/t0 {\"params\":\"ffde71f2990949351222f5fe8968cde1d819703c\"}\r\n2015-06-19 15:35:06.416 HTTP.server  INFO : Connection 15: POST /tag/update/t0\r\n2015-06-19 15:35:06.416 HTTP.server  DEBUG: process: length=53 body=\"{\\\"params\\\":\\\"ffde71f2990949351222f5fe8968cde1d819703c\\\"}\"\r\n2015-06-19 15:35:06.416 MEM          DEBUG: update\r\n2015-06-19 15:35:06.416 WATCH        DEBUG: notify-all[3.0]: firing!\r\n2015-06-19 15:35:06.416 WATCH        DEBUG: notify-all[3.1]: firing!\r\n2015-06-19 15:35:06.416 HTTP.server  INFO : Connection 14: POST /tag/watch\r\n2015-06-19 15:35:06.416 HTTP.server  DEBUG: process: length=115 body=\"{\\\"task\\\":{\\\"date\\\":\\\"1434724506\\\",\\\"uid\\\":\\\"661\\\",\\\"owner\\\":\\\"Irmin piana.mac.cl.cam.ac.uk.[..\"\r\n2015-06-19 15:35:06.416 HTTP         DEBUG: got response: {\"result\":null}\r\n2015-06-19 15:35:06.416 WATCH        DEBUG: watch [3: 0k/2g]: id=2\r\n2015-06-19 15:35:06.416              DEBUG: check-worker: expected 0/1, got 0/0\r\n2015-06-19 15:35:06.416 HTTP.server  DEBUG: Connection 15: closed!\r\n2015-06-19 15:35:06.418              DEBUG: Test.retry 0, 0.001s\r\n2015-06-19 15:35:06.418              DEBUG: check-worker: expected 0/1, got 0/0\r\n2015-06-19 15:35:06.420              DEBUG: Test.retry 1, 0.004s\r\n...\r\n2015-06-19 15:40:06.957              DEBUG: Test.retry 320, 300.541s\r\n2015-06-19 15:40:06.958              DEBUG: check-worker: expected 0/1, got 0/0\r\n2015-06-19 15:40:06.965 MEM          DEBUG: iter\r\n                  [ERROR]\r\nFailure(\"Fail workers:  watch-tag add 0:true x=1/0/0:1/1 s=0/0/0:0/0 0/0 (321, 300.541s): expecting 0/0, got 0/1\")\r\n```"}}