Return-Path: Delivered-To: apmail-felix-dev-archive@www.apache.org Received: (qmail 26894 invoked from network); 24 Jul 2008 18:06:01 -0000 Received: from hermes.apache.org (HELO mail.apache.org) (140.211.11.2) by minotaur.apache.org with SMTP; 24 Jul 2008 18:06:01 -0000 Received: (qmail 49909 invoked by uid 500); 24 Jul 2008 18:05:59 -0000 Delivered-To: apmail-felix-dev-archive@felix.apache.org Received: (qmail 49870 invoked by uid 500); 24 Jul 2008 18:05:59 -0000 Mailing-List: contact dev-help@felix.apache.org; run by ezmlm Precedence: bulk List-Help: List-Unsubscribe: List-Post: List-Id: Reply-To: dev@felix.apache.org Delivered-To: mailing list dev@felix.apache.org Received: (qmail 49859 invoked by uid 99); 24 Jul 2008 18:05:59 -0000 Received: from athena.apache.org (HELO athena.apache.org) (140.211.11.136) by apache.org (qpsmtpd/0.29) with ESMTP; Thu, 24 Jul 2008 11:05:59 -0700 X-ASF-Spam-Status: No, hits=-1998.5 required=10.0 tests=ALL_TRUSTED,NORMAL_HTTP_TO_IP,WEIRD_PORT X-Spam-Check-By: apache.org Received: from [140.211.11.140] (HELO brutus.apache.org) (140.211.11.140) by apache.org (qpsmtpd/0.29) with ESMTP; Thu, 24 Jul 2008 18:05:06 +0000 Received: from brutus (localhost [127.0.0.1]) by brutus.apache.org (Postfix) with ESMTP id C34A2234C185 for ; Thu, 24 Jul 2008 11:05:31 -0700 (PDT) Message-ID: <925648014.1216922731798.JavaMail.jira@brutus> Date: Thu, 24 Jul 2008 11:05:31 -0700 (PDT) From: "Daniel Felsing (JIRA)" To: dev@felix.apache.org Subject: [jira] Commented: (FELIX-642) initial event delivery for new event listeners fails random devices In-Reply-To: <828609515.1216914811709.JavaMail.jira@brutus> MIME-Version: 1.0 Content-Type: text/plain; charset=utf-8 Content-Transfer-Encoding: 7bit X-Virus-Checked: Checked by ClamAV on apache.org [ https://issues.apache.org/jira/browse/FELIX-642?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel&focusedCommentId=12616558#action_12616558 ] Daniel Felsing commented on FELIX-642: -------------------------------------- i have a log which may be valuable...(from the central smart home server which imports the devices...) i ran the upnp event tester which is registering the upnpeventlistener to get ALL initial events..... i set the log level of the basedriver to 4...... the two lines like --> uuid:AT-SM-FHZ1-motionsensor1 urn:upnp-org:serviceId:GetEstimate:1EstimatedValue 0 #diff Devices:1 between the other messages of the log are showing the output of the TESTER.....the rest are logs from basedriver only 16 of the17 devices have shown initial values... dunnow how about services...it may be that one of the 16 shown devices has also single services missing (like already mentioned...its a per service, not per device issue) ==> 72 is the tester device osgi> start 72debug 20080724 19:54:47 bid#78 - [Importer] deviceNotifyReceived debug 20080724 19:54:47 bid#78 - ================REQUEST===================== NOTIFY * HTTP/1.1 Server: Linux/2.6.20-17-generic UPnP/1.0 CyberDomo/1.8 Cache-Control: max-age=1800 Location: http://192.168.0.11:4020/gen-desc.xml NTS: ssdp:alive NT: upnp:rootdevice USN: uuid:AT-SM-FHZ1-rainsensor1::upnp:rootdevice HOST: 239.255.255.250:1900 -------------------------------------------- debug 20080724 19:54:47 bid#78 - [Importer] ssdpPacket.isAlive debug 20080724 19:54:47 bid#78 - [Importer] Device already discovered debug 20080724 19:54:47 bid#78 - [Importer] deviceNotifyReceived debug 20080724 19:54:47 bid#78 - ================REQUEST===================== NOTIFY * HTTP/1.1 Server: Linux/2.6.20-17-generic UPnP/1.0 CyberDomo/1.8 Cache-Control: max-age=1800 Location: http://192.168.0.11:4020/gen-desc.xml NTS: ssdp:alive NT: uuid:AT-SM-FHZ1-rainsensor1 USN: uuid:AT-SM-FHZ1-rainsensor1 HOST: 239.255.255.250:1900 -------------------------------------------- debug 20080724 19:54:47 bid#78 - [Importer] ssdpPacket.isAlive debug 20080724 19:54:47 bid#78 - [Importer] Device already discovered debug 20080724 19:54:47 bid#78 - [Importer] deviceNotifyReceived debug 20080724 19:54:47 bid#78 - ================REQUEST===================== NOTIFY * HTTP/1.1 Server: Linux/2.6.20-17-generic UPnP/1.0 CyberDomo/1.8 Cache-Control: max-age=1800 Location: http://192.168.0.11:4020/gen-desc.xml NTS: ssdp:alive NT: urn:schemas-upnp-org:device:FHZRainSensor:1 USN: uuid:AT-SM-FHZ1-rainsensor1::urn:schemas-upnp-org:device:FHZRainSensor:1 HOST: 239.255.255.250:1900 -------------------------------------------- debug 20080724 19:54:47 bid#78 - [Importer] ssdpPacket.isAlive debug 20080724 19:54:47 bid#78 - [Importer] Device already discovered debug 20080724 19:54:48 bid#78 - [Importer] deviceNotifyReceived debug 20080724 19:54:48 bid#78 - ================REQUEST===================== NOTIFY * HTTP/1.1 Server: Linux/2.6.20-17-generic UPnP/1.0 CyberDomo/1.8 Cache-Control: max-age=1800 Location: http://192.168.0.11:4020/gen-desc.xml NTS: ssdp:alive NT: urn:schemas-upnp-org:service:GetName:1 USN: uuid:AT-SM-FHZ1-rainsensor1::urn:schemas-upnp-org:service:GetName:1 HOST: 239.255.255.250:1900 -------------------------------------------- debug 20080724 19:54:48 bid#78 - [Importer] ssdpPacket.isAlive debug 20080724 19:54:48 bid#78 - [Importer] Device already discovered debug 20080724 19:54:48 bid#78 - [Importer] check for service updating info 20080724 19:54:48 bid#72 - [51;org.osgi.service.upnp.UPnPEventListener] ServiceEvent REGISTERED debug 20080724 19:54:48 bid#78 - [Importer] serviceChanged debug 20080724 19:54:48 bid#78 - Event::org.osgi.framework.ServiceEvent[source={org.osgi.service.upnp.UPnPEventListener}={service.id=51}] osgi> info 20080724 19:54:48 bid#72 - BundleEvent STARTED CyberDomo message : sock = /192.168.0.11:46700 CyberDomo message : httpServThread ... CyberDomo message : accept ... debug 20080724 19:54:48 bid#78 - [Importer] deviceNotifyReceived debug 20080724 19:54:48 bid#78 - ================REQUEST===================== NOTIFY * HTTP/1.1 Server: Linux/2.6.20-17-generic UPnP/1.0 CyberDomo/1.8 Cache-Control: max-age=1800 Location: http://192.168.0.11:4020/gen-desc.xml NTS: ssdp:alive NT: urn:schemas-upnp-org:service:GetStatus:1 USN: uuid:AT-SM-FHZ1-rainsensor1::urn:schemas-upnp-org:service:GetStatus:1 HOST: 239.255.255.250:1900 -------------------------------------------- debug 20080724 19:54:48 bid#78 - [Importer] ssdpPacket.isAlive debug 20080724 19:54:48 bid#78 - [Importer] Device already discovered debug 20080724 19:54:48 bid#78 - [Importer] check for service updating debug 20080724 19:54:48 bid#78 - [Importer] httpRequestRecieved event debug 20080724 19:54:48 bid#78 - ================REQUEST===================== NOTIFY /evetSub HTTP/1.0 Content-Type: text/xml; charset="utf-8" HOST: 192.168.0.5 NT: upnp:event NTS: upnp:propchange SID: uuid:8fed-a11b-e80b-e0ca SEQ: 0 Content-Length: 179 Connection: close 0 -------------------------------------------- debug 20080724 19:54:48 bid#78 - [Importer] Notify Request debug 20080724 19:54:48 bid#78 - [Importer] newEventArrived uuid:AT-SM-FHZ1-motionsensor1 urn:upnp-org:serviceId:GetEstimate:1EstimatedValue 0 #diff Devices:1 CyberDomo message : sock = /192.168.0.11:43768 CyberDomo message : httpServThread ... CyberDomo message : accept ... debug 20080724 19:54:48 bid#78 - [Importer] httpRequestRecieved event debug 20080724 19:54:48 bid#78 - ================REQUEST===================== NOTIFY /evetSub HTTP/1.0 Content-Type: text/xml; charset="utf-8" HOST: 192.168.0.5 NT: upnp:event NTS: upnp:propchange SID: uuid:90b8-a11b-c447-e0f0 SEQ: 0 Content-Length: 160 Connection: close -------------------------------------------- debug 20080724 19:54:48 bid#78 - [Importer] Notify Request debug 20080724 19:54:48 bid#78 - [Importer] newEventArrived uuid:AT-SM-FHZ1-motionsensor1 urn:upnp-org:serviceId:GetEvent:1Event #diff Devices:1 CyberDomo message : sock = /192.168.0.11:50031 CyberDomo message : httpServThread ... CyberDomo message : accept ... debug 20080724 19:54:48 bid#78 - [Importer] httpRequestRecieved event debug 20080724 19:54:48 bid#78 - ================REQUEST===================== NOTIFY /evetSub HTTP/1.0 Content-Type: text/xml; charset="utf-8" HOST: 192.168.0.5 NT: upnp:event NTS: upnp:propchange SID: uuid:9183-a11b-c553-e08c SEQ: 0 Content-Length: 164 Connection: close on -------------------------------------------- debug 20080724 19:54:48 bid#78 - [Importer] Notify Request debug 20080724 19:54:48 bid#78 - [Importer] newEventArrived uuid:AT-SM-FHZ1-dimswitch4 urn:upnp-org:serviceId:GetStatus:1Status on #diff Devices:2 CyberDomo message : sock = /192.168.0.11:43741 CyberDomo message : httpServThread ... CyberDomo message : accept ... debug 20080724 19:54:49 bid#78 - [Importer] httpRequestRecieved event debug 20080724 19:54:49 bid#78 - ================REQUEST===================== NOTIFY /evetSub HTTP/1.0 Content-Type: text/xml; charset="utf-8" HOST: 192.168.0.5 NT: upnp:event NTS: upnp:propchange SID: uuid:924a-a11b-ebf6-e072 SEQ: 0 Content-Length: 162 Connection: close 34 -------------------------------------------- debug 20080724 19:54:49 bid#78 - [Importer] Notify Request debug 20080724 19:54:49 bid#78 - [Importer] newEventArrived uuid:AT-SM-FHZ1-dimswitch4 urn:upnp-org:serviceId:GetLevel:1Level 34 #diff Devices:2 CyberDomo message : sock = /192.168.0.11:60193 CyberDomo message : httpServThread ... CyberDomo message : accept ... debug 20080724 19:54:49 bid#78 - [Importer] httpRequestRecieved event debug 20080724 19:54:49 bid#78 - ================REQUEST===================== NOTIFY /evetSub HTTP/1.0 Content-Type: text/xml; charset="utf-8" HOST: 192.168.0.5 NT: upnp:event NTS: upnp:propchange SID: uuid:9316-a11b-e0cb-e01d SEQ: 0 Content-Length: 165 Connection: close off -------------------------------------------- debug 20080724 19:54:49 bid#78 - [Importer] Notify Request debug 20080724 19:54:49 bid#78 - [Importer] newEventArrived uuid:AT-SM-FHZ1-dimmablelight1 urn:upnp-org:serviceId:SwitchDevice:1Status off #diff Devices:3 CyberDomo message : sock = /192.168.0.11:56040 CyberDomo message : httpServThread ... CyberDomo message : accept ... debug 20080724 19:54:49 bid#78 - [Importer] httpRequestRecieved event debug 20080724 19:54:49 bid#78 - ================REQUEST===================== NOTIFY /evetSub HTTP/1.0 Content-Type: text/xml; charset="utf-8" HOST: 192.168.0.5 NT: upnp:event NTS: upnp:propchange SID: uuid:93db-a11b-f0c5-e07b SEQ: 0 Content-Length: 161 Connection: close 0 -------------------------------------------- debug 20080724 19:54:49 bid#78 - [Importer] Notify Request debug 20080724 19:54:49 bid#78 - [Importer] newEventArrived uuid:AT-SM-FHZ1-dimmablelight1 urn:upnp-org:serviceId:DimDevice:1Level 0 #diff Devices:3 CyberDomo message : sock = /192.168.0.11:48067 CyberDomo message : httpServThread ... CyberDomo message : accept ... debug 20080724 19:54:49 bid#78 - [Importer] httpRequestRecieved event debug 20080724 19:54:49 bid#78 - ================REQUEST===================== NOTIFY /evetSub HTTP/1.0 Content-Type: text/xml; charset="utf-8" HOST: 192.168.0.5 NT: upnp:event NTS: upnp:propchange SID: uuid:94a6-a11b-eb43-e007 SEQ: 0 Content-Length: 164 Connection: close on -------------------------------------------- debug 20080724 19:54:49 bid#78 - [Importer] Notify Request debug 20080724 19:54:49 bid#78 - [Importer] newEventArrived uuid:AT-SM-FHZ1-switch3 urn:upnp-org:serviceId:GetStatus:1Status on #diff Devices:4 CyberDomo message : sock = /192.168.0.11:39333 CyberDomo message : httpServThread ... CyberDomo message : accept ... debug 20080724 19:54:49 bid#78 - [Importer] httpRequestRecieved event debug 20080724 19:54:49 bid#78 - ================REQUEST===================== NOTIFY /evetSub HTTP/1.0 Content-Type: text/xml; charset="utf-8" HOST: 192.168.0.5 NT: upnp:event NTS: upnp:propchange SID: uuid:956d-a11b-fe88-e08e SEQ: 0 Content-Length: 165 Connection: close off -------------------------------------------- debug 20080724 19:54:49 bid#78 - [Importer] Notify Request debug 20080724 19:54:49 bid#78 - [Importer] newEventArrived uuid:AT-SM-FHZ1-S20_Switch3 urn:upnp-org:serviceId:GetStatus:1Status off #diff Devices:5 CyberDomo message : sock = /192.168.0.11:34372 CyberDomo message : httpServThread ... CyberDomo message : accept ... debug 20080724 19:54:50 bid#78 - [Importer] httpRequestRecieved event debug 20080724 19:54:50 bid#78 - ================REQUEST===================== NOTIFY /evetSub HTTP/1.0 Content-Type: text/xml; charset="utf-8" HOST: 192.168.0.5 NT: upnp:event NTS: upnp:propchange SID: uuid:9637-a11b-7b53-e0af SEQ: 0 Content-Length: 161 Connection: close 0 -------------------------------------------- debug 20080724 19:54:50 bid#78 - [Importer] Notify Request debug 20080724 19:54:50 bid#78 - [Importer] newEventArrived CyberDomo message : sock = /192.168.0.11:58961 CyberDomo message : httpServThread ... CyberDomo message : accept ... debug 20080724 19:54:50 bid#78 - [Importer] httpRequestRecieved event debug 20080724 19:54:50 bid#78 - ================REQUEST===================== NOTIFY /evetSub HTTP/1.0 Content-Type: text/xml; charset="utf-8" HOST: 192.168.0.5 NT: upnp:event NTS: upnp:propchange SID: uuid:9701-a11b-eafd-e075 SEQ: 0 Content-Length: 165 Connection: close off -------------------------------------------- debug 20080724 19:54:50 bid#78 - [Importer] Notify Request debug 20080724 19:54:50 bid#78 - [Importer] newEventArrived CyberDomo message : sock = /192.168.0.11:50563 CyberDomo message : httpServThread ... CyberDomo message : accept ... debug 20080724 19:54:50 bid#78 - [Importer] httpRequestRecieved event debug 20080724 19:54:50 bid#78 - ================REQUEST===================== NOTIFY /evetSub HTTP/1.0 Content-Type: text/xml; charset="utf-8" HOST: 192.168.0.5 NT: upnp:event NTS: upnp:propchange SID: uuid:97cb-a11b-3f58-e10b SEQ: 0 Content-Length: 161 Connection: close 0 -------------------------------------------- debug 20080724 19:54:50 bid#78 - [Importer] Notify Request debug 20080724 19:54:50 bid#78 - [Importer] newEventArrived CyberDomo message : sock = /192.168.0.11:37457 CyberDomo message : httpServThread ... CyberDomo message : accept ... debug 20080724 19:54:50 bid#78 - [Importer] httpRequestRecieved event debug 20080724 19:54:50 bid#78 - ================REQUEST===================== NOTIFY /evetSub HTTP/1.0 Content-Type: text/xml; charset="utf-8" HOST: 192.168.0.5 NT: upnp:event NTS: upnp:propchange SID: uuid:9893-a11b-c7b3-e082 SEQ: 0 Content-Length: 164 Connection: close on -------------------------------------------- debug 20080724 19:54:50 bid#78 - [Importer] Notify Request debug 20080724 19:54:50 bid#78 - [Importer] newEventArrived uuid:AT-SM-FHZ1-S20_Switch7 urn:upnp-org:serviceId:GetStatus:1Status on #diff Devices:6 CyberDomo message : sock = /192.168.0.11:50267 CyberDomo message : httpServThread ... CyberDomo message : accept ... debug 20080724 19:54:50 bid#78 - [Importer] httpRequestRecieved event debug 20080724 19:54:50 bid#78 - ================REQUEST===================== NOTIFY /evetSub HTTP/1.0 Content-Type: text/xml; charset="utf-8" HOST: 192.168.0.5 NT: upnp:event NTS: upnp:propchange SID: uuid:995d-a11b-2121-e018 SEQ: 0 Content-Length: 163 Connection: close 100 -------------------------------------------- debug 20080724 19:54:50 bid#78 - [Importer] Notify Request debug 20080724 19:54:50 bid#78 - [Importer] newEventArrived CyberDomo message : sock = /192.168.0.11:42546 CyberDomo message : httpServThread ... CyberDomo message : accept ... debug 20080724 19:54:51 bid#78 - [Importer] httpRequestRecieved event debug 20080724 19:54:51 bid#78 - ================REQUEST===================== NOTIFY /evetSub HTTP/1.0 Content-Type: text/xml; charset="utf-8" HOST: 192.168.0.5 NT: upnp:event NTS: upnp:propchange SID: uuid:9a2a-a11b-b56a-e0a8 SEQ: 0 Content-Length: 165 Connection: close off -------------------------------------------- debug 20080724 19:54:51 bid#78 - [Importer] Notify Request debug 20080724 19:54:51 bid#78 - [Importer] newEventArrived uuid:AT-SM-FHZ1-S20_Switch4 urn:upnp-org:serviceId:GetStatus:1Status off #diff Devices:7 CyberDomo message : sock = /192.168.0.11:50869 CyberDomo message : httpServThread ... CyberDomo message : accept ... debug 20080724 19:54:51 bid#78 - [Importer] httpRequestRecieved event debug 20080724 19:54:51 bid#78 - ================REQUEST===================== NOTIFY /evetSub HTTP/1.0 Content-Type: text/xml; charset="utf-8" HOST: 192.168.0.5 NT: upnp:event NTS: upnp:propchange SID: uuid:9afc-a11b-f9e8-e103 SEQ: 0 Content-Length: 161 Connection: close 0 -------------------------------------------- debug 20080724 19:54:51 bid#78 - [Importer] Notify Request debug 20080724 19:54:51 bid#78 - [Importer] newEventArrived uuid:AT-SM-FHZ1-S20_Switch4 urn:upnp-org:serviceId:GetLevel:1Level 0 #diff Devices:7 CyberDomo message : sock = /192.168.0.11:35584 CyberDomo message : httpServThread ... CyberDomo message : accept ... debug 20080724 19:54:51 bid#78 - [Importer] httpRequestRecieved event debug 20080724 19:54:51 bid#78 - ================REQUEST===================== NOTIFY /evetSub HTTP/1.0 Content-Type: text/xml; charset="utf-8" HOST: 192.168.0.5 NT: upnp:event NTS: upnp:propchange SID: uuid:9bc2-a11b-a1db-e06c SEQ: 0 Content-Length: 164 Connection: close on -------------------------------------------- debug 20080724 19:54:51 bid#78 - [Importer] Notify Request debug 20080724 19:54:51 bid#78 - [Importer] newEventArrived uuid:AT-SM-FHZ1-S20_Switch5 urn:upnp-org:serviceId:GetStatus:1Status on #diff Devices:8 CyberDomo message : sock = /192.168.0.11:39669 CyberDomo message : httpServThread ... CyberDomo message : accept ... debug 20080724 19:54:51 bid#78 - [Importer] httpRequestRecieved event debug 20080724 19:54:51 bid#78 - ================REQUEST===================== NOTIFY /evetSub HTTP/1.0 Content-Type: text/xml; charset="utf-8" HOST: 192.168.0.5 NT: upnp:event NTS: upnp:propchange SID: uuid:9c8d-a11b-d4e0-e073 SEQ: 0 Content-Length: 163 Connection: close 100 -------------------------------------------- debug 20080724 19:54:51 bid#78 - [Importer] Notify Request debug 20080724 19:54:51 bid#78 - [Importer] newEventArrived uuid:AT-SM-FHZ1-S20_Switch5 urn:upnp-org:serviceId:GetLevel:1Level 100 #diff Devices:8 CyberDomo message : sock = /192.168.0.11:44317 CyberDomo message : httpServThread ... CyberDomo message : accept ... debug 20080724 19:54:51 bid#78 - [Importer] httpRequestRecieved event debug 20080724 19:54:51 bid#78 - ================REQUEST===================== NOTIFY /evetSub HTTP/1.0 Content-Type: text/xml; charset="utf-8" HOST: 192.168.0.5 NT: upnp:event NTS: upnp:propchange SID: uuid:9d53-a11b-fdd2-e06a SEQ: 0 Content-Length: 164 Connection: close on -------------------------------------------- debug 20080724 19:54:51 bid#78 - [Importer] Notify Request debug 20080724 19:54:51 bid#78 - [Importer] newEventArrived uuid:AT-SM-FHZ1-simplelight1 urn:upnp-org:serviceId:SwitchDevice:1Status on #diff Devices:9 CyberDomo message : sock = /192.168.0.11:54870 CyberDomo message : httpServThread ... CyberDomo message : accept ... debug 20080724 19:54:52 bid#78 - [Importer] httpRequestRecieved event debug 20080724 19:54:52 bid#78 - ================REQUEST===================== NOTIFY /evetSub HTTP/1.0 Content-Type: text/xml; charset="utf-8" HOST: 192.168.0.5 NT: upnp:event NTS: upnp:propchange SID: uuid:9e1b-a11b-a048-e0be SEQ: 0 Content-Length: 164 Connection: close on -------------------------------------------- debug 20080724 19:54:52 bid#78 - [Importer] Notify Request debug 20080724 19:54:52 bid#78 - [Importer] newEventArrived uuid:AT-SM-FHZ1-S20_Switch2 urn:upnp-org:serviceId:GetStatus:1Status on #diff Devices:10 CyberDomo message : sock = /192.168.0.11:38177 CyberDomo message : httpServThread ... CyberDomo message : accept ... debug 20080724 19:54:52 bid#78 - [Importer] httpRequestRecieved event debug 20080724 19:54:52 bid#78 - ================REQUEST===================== NOTIFY /evetSub HTTP/1.0 Content-Type: text/xml; charset="utf-8" HOST: 192.168.0.5 NT: upnp:event NTS: upnp:propchange SID: uuid:9ee3-a11b-ff74-e0c5 SEQ: 0 Content-Length: 163 Connection: close 100 -------------------------------------------- debug 20080724 19:54:52 bid#78 - [Importer] Notify Request debug 20080724 19:54:52 bid#78 - [Importer] newEventArrived uuid:AT-SM-FHZ1-S20_Switch2 urn:upnp-org:serviceId:GetLevel:1Level 100 #diff Devices:10 CyberDomo message : sock = /192.168.0.11:46611 CyberDomo message : httpServThread ... CyberDomo message : accept ... debug 20080724 19:54:52 bid#78 - [Importer] httpRequestRecieved event debug 20080724 19:54:52 bid#78 - ================REQUEST===================== NOTIFY /evetSub HTTP/1.0 Content-Type: text/xml; charset="utf-8" HOST: 192.168.0.5 NT: upnp:event NTS: upnp:propchange SID: uuid:9fac-a11b-7a23-e116 SEQ: 0 Content-Length: 165 Connection: close off -------------------------------------------- debug 20080724 19:54:52 bid#78 - [Importer] Notify Request debug 20080724 19:54:52 bid#78 - [Importer] newEventArrived uuid:AT-SM-FHZ1-funksteckdose1 urn:upnp-org:serviceId:SwitchDevice:1Status off #diff Devices:11 CyberDomo message : sock = /192.168.0.11:49532 CyberDomo message : httpServThread ... CyberDomo message : accept ... debug 20080724 19:54:52 bid#78 - [Importer] httpRequestRecieved event debug 20080724 19:54:52 bid#78 - ================REQUEST===================== NOTIFY /evetSub HTTP/1.0 Content-Type: text/xml; charset="utf-8" HOST: 192.168.0.5 NT: upnp:event NTS: upnp:propchange SID: uuid:a072-a11b-4847-e0d4 SEQ: 0 Content-Length: 165 Connection: close off -------------------------------------------- debug 20080724 19:54:52 bid#78 - [Importer] Notify Request debug 20080724 19:54:52 bid#78 - [Importer] newEventArrived uuid:AT-SM-FHZ1-dawnsensor2 urn:upnp-org:serviceId:GetStatus:1Status off #diff Devices:12 CyberDomo message : sock = /192.168.0.11:58959 CyberDomo message : httpServThread ... CyberDomo message : accept ... debug 20080724 19:54:52 bid#78 - [Importer] httpRequestRecieved event debug 20080724 19:54:52 bid#78 - ================REQUEST===================== NOTIFY /evetSub HTTP/1.0 Content-Type: text/xml; charset="utf-8" HOST: 192.168.0.5 NT: upnp:event NTS: upnp:propchange SID: uuid:a13a-a11b-a345-e00a SEQ: 0 Content-Length: 164 Connection: close on -------------------------------------------- debug 20080724 19:54:52 bid#78 - [Importer] Notify Request debug 20080724 19:54:52 bid#78 - [Importer] newEventArrived uuid:AT-SM-FHZ1-S20_Switch1 urn:upnp-org:serviceId:GetStatus:1Status on #diff Devices:13 CyberDomo message : sock = /192.168.0.11:46776 CyberDomo message : httpServThread ... CyberDomo message : accept ... CyberDomo message : sock = /192.168.0.11:57175 debug 20080724 19:54:53 bid#78 - [Importer] httpRequestRecieved event CyberDomo message : httpServThread ... debug 20080724 19:54:53 bid#78 - ================REQUEST===================== NOTIFY /evetSub HTTP/1.0 Content-Type: text/xml; charset="utf-8" HOST: 192.168.0.5 NT: upnp:event NTS: upnp:propchange SID: uuid:a1fe-a11b-de65-e110 SEQ: 0 Content-Length: 163 Connection: close 100 -------------------------------------------- CyberDomo message : accept ... debug 20080724 19:54:53 bid#78 - [Importer] Notify Request debug 20080724 19:54:53 bid#78 - [Importer] newEventArrived uuid:AT-SM-FHZ1-S20_Switch1 urn:upnp-org:serviceId:GetLevel:1Level 100 #diff Devices:13 debug 20080724 19:54:53 bid#78 - [Importer] httpRequestRecieved event debug 20080724 19:54:53 bid#78 - ================REQUEST===================== NOTIFY /evetSub HTTP/1.0 Content-Type: text/xml; charset="utf-8" HOST: 192.168.0.5 NT: upnp:event NTS: upnp:propchange SID: uuid:a2c2-a11b-220f-e020 SEQ: 0 Content-Length: 165 Connection: close off -------------------------------------------- debug 20080724 19:54:53 bid#78 - [Importer] Notify Request debug 20080724 19:54:53 bid#78 - [Importer] newEventArrived uuid:AT-SM-FHZ1-S20_Switch6 urn:upnp-org:serviceId:GetStatus:1Status off #diff Devices:14 CyberDomo message : sock = /192.168.0.11:52541 CyberDomo message : httpServThread ... CyberDomo message : accept ... debug 20080724 19:54:53 bid#78 - [Importer] httpRequestRecieved event debug 20080724 19:54:53 bid#78 - ================REQUEST===================== NOTIFY /evetSub HTTP/1.0 Content-Type: text/xml; charset="utf-8" HOST: 192.168.0.5 NT: upnp:event NTS: upnp:propchange SID: uuid:a38c-a11b-696e-e0ad SEQ: 0 Content-Length: 161 Connection: close 0 -------------------------------------------- debug 20080724 19:54:53 bid#78 - [Importer] Notify Request debug 20080724 19:54:53 bid#78 - [Importer] newEventArrived CyberDomo message : sock = /192.168.0.11:54229 CyberDomo message : httpServThread ... CyberDomo message : accept ... CyberDomo message : sock = /192.168.0.11:53133 CyberDomo message : httpServThread ... CyberDomo message : accept ... debug 20080724 19:54:53 bid#78 - [Importer] httpRequestRecieved event debug 20080724 19:54:53 bid#78 - ================REQUEST===================== NOTIFY /evetSub HTTP/1.0 Content-Type: text/xml; charset="utf-8" HOST: 192.168.0.5 NT: upnp:event NTS: upnp:propchange SID: uuid:a454-a11b-982e-e023 SEQ: 0 Content-Length: 164 Connection: close on -------------------------------------------- debug 20080724 19:54:53 bid#78 - [Importer] Notify Request debug 20080724 19:54:53 bid#78 - [Importer] newEventArrived uuid:AT-SM-FHZ1-rainsensor1 urn:upnp-org:serviceId:GetStatus:1Status on #diff Devices:15 debug 20080724 19:54:53 bid#78 - [Importer] httpRequestRecieved event debug 20080724 19:54:53 bid#78 - ================REQUEST===================== NOTIFY /evetSub HTTP/1.0 Content-Type: text/xml; charset="utf-8" HOST: 192.168.0.5 NT: upnp:event NTS: upnp:propchange SID: uuid:a51a-a11b-feda-e08d SEQ: 0 Content-Length: 164 Connection: close on -------------------------------------------- debug 20080724 19:54:53 bid#78 - [Importer] Notify Request debug 20080724 19:54:53 bid#78 - [Importer] newEventArrived uuid:AT-SM-FHZ1-shutter1 urn:upnp-org:serviceId:SwitchDevice:1Status on #diff Devices:16 > initial event delivery for new event listeners fails random devices > ------------------------------------------------------------------- > > Key: FELIX-642 > URL: https://issues.apache.org/jira/browse/FELIX-642 > Project: Felix > Issue Type: Bug > Components: UPnP Subproject > Affects Versions: upnp-basedriver-0.8.0 > Reporter: Daniel Felsing > Priority: Blocker > Fix For: upnp-basedriver-0.8.0 > > > Hi Daniel, > let's try to summarize this long thread, so that we can get a clear vision on what is going on, and you can correct my wrong understanding > Overall Environment Setup > ------------------------- > - You have two computer connected togheter by means of a switch. And they are the only two computer on the network > - The first computer runs Felix + UPnP Base Driver > - The second computer runs Equinox + UPnP Base Driver + *your* Sensor Base Driver + Sensor2UPnP Bridge > Issues > ------ > - If you subscribe from the PC running Felix to all the UPnP Device exported by the UPnP Base Driver running on Equinox and created by your Sensor2UPnP bridge you miss some of the notification. > Questions & Tests > ----------------- > - Can you create a JIRA issue for your issue, so that it will easy to track and you will be able to post your code as zip file, instead of copy & paste > - During your testing have you always discovered all the device exported by the Equinox computer in the Felix computer? > - Do you miss notification even on the Equinox computer? > Ciao, > Stefano "Kismet" Lenzi > Overall Environment Setup: > -------------------------- > - yes, connected by a switch > - the first computer is a UPnP Bridge for a X10 "like" system..i wrote a basedriver and upnpbridgedriver (bridgedriver is creating upnp devices for every x10 base device). It is using felix + upnpbasedriver > - the second computer acts as a server (central control point for a smart home system implementation) it's using felix also (but for developing eclipse equinox since it's more comfortable to develop) This second computer uses basedriver to import the devices xposed by the first computer...and a refinement driver is creating new objects for every upnp device found (e.g. a light device and so on) > Issues: > ------ > - all the devices on the server (so the central smart home controller) that get imported get refined. They subscribe to the upnp device it refines to get notified on event change. > Problem is: not all devices refined devices which act as listeners on the SERVER get notified on INITIAL subscription (when i subscribe the device with felix tester also no notification is delivered....)...when this happens and i actually change the state of a sensor a notification is sent (to the device and upnp felix tester) and everything begins to work properly. > Question & Tests: > ----------------- > - yes i can :) > - yes - every device exported by the upnpsensorbridge (=Felix Computer) gets found by the central server (=equinox computer) It is really just an issue with single "upnpservices". Here i saw something strange. When i restart the bridgeDriver on Felix computer (exporting my upnp devices) The "getCurrentValue()" methods get called more and more often the more often i restart the "bridgeDriver". Is this a normal behavior? It seems to me as state variables Of the services get mixed up or not cancelled when unregistering or something. > - i have only one computer where i test the notification -> on the central equinox server computer. > On the felix computer exporting my upnp devices i am justwondering about the strange calls to "getCurrentValue" i described you > some code parts that may be for particular interest: > --------------------------------------------------------------------- > UPnP Event Tester code on the SERVER side (central server importing the upnp devices from the second one) > public class Activator implements BundleActivator { > private ServiceRegistration servReg; > > /* > * (non-Javadoc) > * @see org.osgi.framework.BundleActivator#start(org.osgi.framework.BundleContext) > */ > public void start(BundleContext context) throws Exception { > EventListener test = new EventListener(); > servReg = context.registerService(UPnPEventListener.class.getName(), test, null); > } > /* > * (non-Javadoc) > * @see org.osgi.framework.BundleActivator#stop(org.osgi.framework.BundleContext) > */ > public void stop(BundleContext context) throws Exception { > servReg.unregister(); > } > } > public class EventListener implements UPnPEventListener { > private ArrayList knownDevs = new ArrayList(); > > @Override > public synchronized void notifyUPnPEvent(String deviceId, String serviceId, Dictionary events) { > String output = ""; > output += deviceId + " " + serviceId; > > Enumeration eventit = events.keys(); > > while (eventit.hasMoreElements()) { > String key = (String) eventit.nextElement(); > output += key + " " + events.get(key) + "\n"; > } > > if (!knownDevs.contains(deviceId)) { > knownDevs.add(deviceId); > } > System.err.println(output + "#diff Devices:" + knownDevs.size()); > System.err.flush(); > > } > } > the REFINED devices on the SERVER themselves are using the felix helper class to subscribe to the events: > // create upnp listener - if evented is true > subscriber = new UPnPSubscriber(bundleContext, this); > subscriber.subscribeAllServicesOf(super.getUPnPDeviceUDN()); > the upnp device implementation on the host exporting the upnp devices are using the following line to expose event notifier > // setup event notifier > notify_switch = new UPnPEventNotifier(context, this, switchdevswitchservice, switchDev); > if you need something else please contact me! :) -- This message is automatically generated by JIRA. - You can reply to this email to add a comment to the issue online.