Bug 69457

Summary:	tests regress with recent sofia-sip
Product:	Telepathy	Reporter:	Guillaume Desmottes <guillaume.desmottes>
Component:	rakia	Assignee:	Mikhail Zabaluev <mikhail.zabaluev>
Status:	RESOLVED NOTOURBUG	QA Contact:	Telepathy bugs list <telepathy-bugs>
Severity:	normal
Priority:	medium	CC:	smcv
Version:	unspecified
Hardware:	Other
OS:	All
Whiteboard:
i915 platform:		i915 features:

Description Guillaume Desmottes 2013-09-17 09:22:02 UTC

The following tests don't pass here with master (54f9beed91796913fe11f0744729185b3f5f148a):

test-message.py
voip/calltest.py
voip/ringing-queued.py
voip/direction-change.py
voip/add-remove-content.py

Comment 1 Guillaume Desmottes 2013-09-17 09:53:08 UTC

It looks like the actual text message is never sent.


Testing test-message.py ...
Waiting for event on: dbus
Adding to queue
got event:
- type dbus-signal
- args: [1L, 1L]
- interface: 'org.freedesktop.Telepathy.Connection'
- path: '/org/freedesktop/Telepathy/Connection/sofiasip/sip/testacc_40127_2e0_2e0_2e1'
- signal: 'StatusChanged'
- subqueue: 'dbus'
- subtype: 'signal'
Adding to queue
got event:
- type sip-register
- body: ''
- headers: {'via': ['SIP/2.0/UDP 127.0.0.1:40885;branch=z9hG4bK4cQp5595N1eDB;received=127.0.0.1;rport=40885'], 'max-forwards': ['70'], 'from': ['<sip:testacc@127.0.0.1>;tag=4Dg58e4S7FSKm'], 'to': ['<sip:testacc@127.0.0.1>'], 'call-id': ['38763c34-9a20-1231-f99d-9c4e365ccaa4'], 'cseq': ['49369391 REGISTER'], 'contact': ['<sip:testacc@127.0.0.1:40885;transport=udp>'], 'user-agent': ['Telepathy-Rakia/0.7.5.1 sofia-sip/1.12.11'], 'allow': ['INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, UPDATE'], 'supported': ['timer, 100rel, path'], 'content-length': ['0']}
- host: '127.0.0.1'
- port: 40885
- sip_message: <SIP Request 31556744:REGISTER sip:127.0.0.1>
- subqueue: 'sip'
- subtype: 'register'
- uri: 'sip:127.0.0.1'
got event:
- type dbus-signal
- args: [1L, 1L]
- interface: 'org.freedesktop.Telepathy.Connection'
- path: '/org/freedesktop/Telepathy/Connection/sofiasip/sip/testacc_40127_2e0_2e0_2e1'
- signal: 'StatusChanged'
- subqueue: 'dbus'
- subtype: 'signal'
not handled

Waiting for event on: dbus
Adding to queue
got event:
- type dbus-signal
- args: [0L, 1L]
- interface: 'org.freedesktop.Telepathy.Connection'
- path: '/org/freedesktop/Telepathy/Connection/sofiasip/sip/testacc_40127_2e0_2e0_2e1'
- signal: 'StatusChanged'
- subqueue: 'dbus'
- subtype: 'signal'
got event:
- type dbus-signal
- args: [0L, 1L]
- interface: 'org.freedesktop.Telepathy.Connection'
- path: '/org/freedesktop/Telepathy/Connection/sofiasip/sip/testacc_40127_2e0_2e0_2e1'
- signal: 'StatusChanged'
- subqueue: 'dbus'
- subtype: 'signal'
handled, took 3.591 ms

Waiting for event on: dbus
Adding to queue
got event:
- type dbus-signal
- args: [[('/org/freedesktop/Telepathy/Connection/sofiasip/sip/testacc_40127_2e0_2e0_2e1/TextChannel2',
   {u'org.freedesktop.Telepathy.Channel.ChannelType': u'org.freedesktop.Telepathy.Channel.Type.Text',
    u'org.freedesktop.Telepathy.Channel.InitiatorHandle': 1L,
    u'org.freedesktop.Telepathy.Channel.InitiatorID': u'sip:testacc@127.0.0.1',
    u'org.freedesktop.Telepathy.Channel.Interface.Messages.DeliveryReportingSupport': 3L,
    u'org.freedesktop.Telepathy.Channel.Interface.Messages.MessagePartSupportFlags': 0L,
    u'org.freedesktop.Telepathy.Channel.Interface.Messages.MessageTypes': [0L],
    u'org.freedesktop.Telepathy.Channel.Interface.Messages.SupportedContentTypes': [u'text/plain'],
    u'org.freedesktop.Telepathy.Channel.Interfaces': [u'org.freedesktop.Telepathy.Channel.Interface.Destroyable',
                                                      u'org.freedesktop.Telepathy.Channel.Interface.Messages'],
    u'org.freedesktop.Telepathy.Channel.Requested': True,
    u'org.freedesktop.Telepathy.Channel.TargetHandle': 2L,
    u'org.freedesktop.Telepathy.Channel.TargetHandleType': 1L,
    u'org.freedesktop.Telepathy.Channel.TargetID': u'sip:user@somewhere.com'})]]
- interface: 'org.freedesktop.Telepathy.Connection.Interface.Requests'
- path: '/org/freedesktop/Telepathy/Connection/sofiasip/sip/testacc_40127_2e0_2e0_2e1'
- signal: 'NewChannels'
- subqueue: 'dbus'
- subtype: 'signal'
Adding to queue
got event:
- type dbus-signal
- args: ['/org/freedesktop/Telepathy/Connection/sofiasip/sip/testacc_40127_2e0_2e0_2e1/TextChannel2',
 u'org.freedesktop.Telepathy.Channel.Type.Text',
 1L,
 2L,
 True]
- interface: 'org.freedesktop.Telepathy.Connection'
- path: '/org/freedesktop/Telepathy/Connection/sofiasip/sip/testacc_40127_2e0_2e0_2e1'
- signal: 'NewChannel'
- subqueue: 'dbus'
- subtype: 'signal'
got event:
- type dbus-signal
- args: [[('/org/freedesktop/Telepathy/Connection/sofiasip/sip/testacc_40127_2e0_2e0_2e1/TextChannel2',
   {u'org.freedesktop.Telepathy.Channel.ChannelType': u'org.freedesktop.Telepathy.Channel.Type.Text',
    u'org.freedesktop.Telepathy.Channel.InitiatorHandle': 1L,
    u'org.freedesktop.Telepathy.Channel.InitiatorID': u'sip:testacc@127.0.0.1',
    u'org.freedesktop.Telepathy.Channel.Interface.Messages.DeliveryReportingSupport': 3L,
    u'org.freedesktop.Telepathy.Channel.Interface.Messages.MessagePartSupportFlags': 0L,
    u'org.freedesktop.Telepathy.Channel.Interface.Messages.MessageTypes': [0L],
    u'org.freedesktop.Telepathy.Channel.Interface.Messages.SupportedContentTypes': [u'text/plain'],
    u'org.freedesktop.Telepathy.Channel.Interfaces': [u'org.freedesktop.Telepathy.Channel.Interface.Destroyable',
                                                      u'org.freedesktop.Telepathy.Channel.Interface.Messages'],
    u'org.freedesktop.Telepathy.Channel.Requested': True,
    u'org.freedesktop.Telepathy.Channel.TargetHandle': 2L,
    u'org.freedesktop.Telepathy.Channel.TargetHandleType': 1L,
    u'org.freedesktop.Telepathy.Channel.TargetID': u'sip:user@somewhere.com'})]]
- interface: 'org.freedesktop.Telepathy.Connection.Interface.Requests'
- path: '/org/freedesktop/Telepathy/Connection/sofiasip/sip/testacc_40127_2e0_2e0_2e1'
- signal: 'NewChannels'
- subqueue: 'dbus'
- subtype: 'signal'
not handled

Waiting for event on: dbus
got event:
- type dbus-signal
- args: ['/org/freedesktop/Telepathy/Connection/sofiasip/sip/testacc_40127_2e0_2e0_2e1/TextChannel2',
 u'org.freedesktop.Telepathy.Channel.Type.Text',
 1L,
 2L,
 True]
- interface: 'org.freedesktop.Telepathy.Connection'
- path: '/org/freedesktop/Telepathy/Connection/sofiasip/sip/testacc_40127_2e0_2e0_2e1'
- signal: 'NewChannel'
- subqueue: 'dbus'
- subtype: 'signal'
handled, took 3.636 ms

Waiting for event on: sip
got event:
- type sip-register
- body: ''
- headers: {'via': ['SIP/2.0/UDP 127.0.0.1:40885;branch=z9hG4bK4cQp5595N1eDB;received=127.0.0.1;rport=40885'], 'max-forwards': ['70'], 'from': ['<sip:testacc@127.0.0.1>;tag=4Dg58e4S7FSKm'], 'to': ['<sip:testacc@127.0.0.1>'], 'call-id': ['38763c34-9a20-1231-f99d-9c4e365ccaa4'], 'cseq': ['49369391 REGISTER'], 'contact': ['<sip:testacc@127.0.0.1:40885;transport=udp>'], 'user-agent': ['Telepathy-Rakia/0.7.5.1 sofia-sip/1.12.11'], 'allow': ['INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, UPDATE'], 'supported': ['timer, 100rel, path'], 'content-length': ['0']}
- host: '127.0.0.1'
- port: 40885
- sip_message: <SIP Request 31556744:REGISTER sip:127.0.0.1>
- subqueue: 'sip'
- subtype: 'register'
- uri: 'sip:127.0.0.1'
not handled

Waiting for event on: sip
Adding to queue
got event:
- type dbus-signal
- args: [[{u'message-sender': 1L,
   u'message-sender-id': u'sip:testacc@127.0.0.1',
   u'message-sent': 1379410911L},
  {u'content': u'Hello',
   u'content-type': u'text/plain',
   u'type': u'text/plain'}],
 0L,
 u'0']
- interface: 'org.freedesktop.Telepathy.Channel.Interface.Messages'
- path: '/org/freedesktop/Telepathy/Connection/sofiasip/sip/testacc_40127_2e0_2e0_2e1/TextChannel2'
- signal: 'MessageSent'
- subqueue: 'dbus'
- subtype: 'signal'
Adding to queue
got event:
- type dbus-signal
- args: [1379410911L, 0L, u'Hello']
- interface: 'org.freedesktop.Telepathy.Channel.Type.Text'
- path: '/org/freedesktop/Telepathy/Connection/sofiasip/sip/testacc_40127_2e0_2e0_2e1/TextChannel2'
- signal: 'Sent'
- subqueue: 'dbus'
- subtype: 'signal'
Adding to queue
got event:
- type sip-message
- allow: 'INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, UPDATE'
- body: ''
- call_id: '3877d784-9a20-1231-f99d-9c4e365ccaa4'
- content_length: '0'
- content_type: 'text/plain'
- cseq: '49369392 MESSAGE'
- from: '<sip:testacc@127.0.0.1>;tag=5p9XaaNX4rF6F'
- headers: {'via': ['SIP/2.0/UDP 127.0.0.1:40885;branch=z9hG4bK6y978UBDgKUjj;received=127.0.0.1;rport=40885'], 'max-forwards': ['70'], 'from': ['<sip:testacc@127.0.0.1>;tag=5p9XaaNX4rF6F'], 'to': ['<sip:user@somewhere.com>'], 'call-id': ['3877d784-9a20-1231-f99d-9c4e365ccaa4'], 'cseq': ['49369392 MESSAGE'], 'user-agent': ['Telepathy-Rakia/0.7.5.1 sofia-sip/1.12.11'], 'allow': ['INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, UPDATE'], 'supported': ['timer, 100rel'], 'content-type': ['text/plain'], 'content-length': ['0']}
- max_forwards: '70'
- sip_message: <SIP Request 31576144:MESSAGE sip:user@somewhere.com>
- subqueue: 'sip'
- subtype: 'message'
- supported: 'timer, 100rel'
- to: '<sip:user@somewhere.com>'
- uri: 'sip:user@somewhere.com'
- user_agent: 'Telepathy-Rakia/0.7.5.1 sofia-sip/1.12.11'
- via: 'SIP/2.0/UDP 127.0.0.1:40885;branch=z9hG4bK6y978UBDgKUjj;received=127.0.0.1;rport=40885'
got event:
- type sip-message
- allow: 'INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, UPDATE'
- body: ''
- call_id: '3877d784-9a20-1231-f99d-9c4e365ccaa4'
- content_length: '0'
- content_type: 'text/plain'
- cseq: '49369392 MESSAGE'
- from: '<sip:testacc@127.0.0.1>;tag=5p9XaaNX4rF6F'
- headers: {'via': ['SIP/2.0/UDP 127.0.0.1:40885;branch=z9hG4bK6y978UBDgKUjj;received=127.0.0.1;rport=40885'], 'max-forwards': ['70'], 'from': ['<sip:testacc@127.0.0.1>;tag=5p9XaaNX4rF6F'], 'to': ['<sip:user@somewhere.com>'], 'call-id': ['3877d784-9a20-1231-f99d-9c4e365ccaa4'], 'cseq': ['49369392 MESSAGE'], 'user-agent': ['Telepathy-Rakia/0.7.5.1 sofia-sip/1.12.11'], 'allow': ['INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, UPDATE'], 'supported': ['timer, 100rel'], 'content-type': ['text/plain'], 'content-length': ['0']}
- max_forwards: '70'
- sip_message: <SIP Request 31576144:MESSAGE sip:user@somewhere.com>
- subqueue: 'sip'
- subtype: 'message'
- supported: 'timer, 100rel'
- to: '<sip:user@somewhere.com>'
- uri: 'sip:user@somewhere.com'
- user_agent: 'Telepathy-Rakia/0.7.5.1 sofia-sip/1.12.11'
- via: 'SIP/2.0/UDP 127.0.0.1:40885;branch=z9hG4bK6y978UBDgKUjj;received=127.0.0.1;rport=40885'
not handled

Waiting for event on: sip
Adding to queue
got event:
- type sip-message
- allow: 'INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, UPDATE'
- body: ''
- call_id: '3877d784-9a20-1231-f99d-9c4e365ccaa4'
- content_length: '0'
- content_type: 'text/plain'
- cseq: '49369392 MESSAGE'
- from: '<sip:testacc@127.0.0.1>;tag=5p9XaaNX4rF6F'
- headers: {'via': ['SIP/2.0/UDP 127.0.0.1:40885;branch=z9hG4bK6y978UBDgKUjj;received=127.0.0.1;rport=40885'], 'max-forwards': ['70'], 'from': ['<sip:testacc@127.0.0.1>;tag=5p9XaaNX4rF6F'], 'to': ['<sip:user@somewhere.com>'], 'call-id': ['3877d784-9a20-1231-f99d-9c4e365ccaa4'], 'cseq': ['49369392 MESSAGE'], 'user-agent': ['Telepathy-Rakia/0.7.5.1 sofia-sip/1.12.11'], 'allow': ['INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, UPDATE'], 'supported': ['timer, 100rel'], 'content-type': ['text/plain'], 'content-length': ['0']}
- max_forwards: '70'
- sip_message: <SIP Request 31556744:MESSAGE sip:user@somewhere.com>
- subqueue: 'sip'
- subtype: 'message'
- supported: 'timer, 100rel'
- to: '<sip:user@somewhere.com>'
- uri: 'sip:user@somewhere.com'
- user_agent: 'Telepathy-Rakia/0.7.5.1 sofia-sip/1.12.11'
- via: 'SIP/2.0/UDP 127.0.0.1:40885;branch=z9hG4bK6y978UBDgKUjj;received=127.0.0.1;rport=40885'
got event:
- type sip-message
- allow: 'INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, UPDATE'
- body: ''
- call_id: '3877d784-9a20-1231-f99d-9c4e365ccaa4'
- content_length: '0'
- content_type: 'text/plain'
- cseq: '49369392 MESSAGE'
- from: '<sip:testacc@127.0.0.1>;tag=5p9XaaNX4rF6F'
- headers: {'via': ['SIP/2.0/UDP 127.0.0.1:40885;branch=z9hG4bK6y978UBDgKUjj;received=127.0.0.1;rport=40885'], 'max-forwards': ['70'], 'from': ['<sip:testacc@127.0.0.1>;tag=5p9XaaNX4rF6F'], 'to': ['<sip:user@somewhere.com>'], 'call-id': ['3877d784-9a20-1231-f99d-9c4e365ccaa4'], 'cseq': ['49369392 MESSAGE'], 'user-agent': ['Telepathy-Rakia/0.7.5.1 sofia-sip/1.12.11'], 'allow': ['INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, UPDATE'], 'supported': ['timer, 100rel'], 'content-type': ['text/plain'], 'content-length': ['0']}
- max_forwards: '70'
- sip_message: <SIP Request 31556744:MESSAGE sip:user@somewhere.com>
- subqueue: 'sip'
- subtype: 'message'
- supported: 'timer, 100rel'
- to: '<sip:user@somewhere.com>'
- uri: 'sip:user@somewhere.com'
- user_agent: 'Telepathy-Rakia/0.7.5.1 sofia-sip/1.12.11'
- via: 'SIP/2.0/UDP 127.0.0.1:40885;branch=z9hG4bK6y978UBDgKUjj;received=127.0.0.1;rport=40885'
not handled

Waiting for event on: sip
Adding to queue
got event:
- type sip-message
- allow: 'INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, UPDATE'
- body: ''
- call_id: '3877d784-9a20-1231-f99d-9c4e365ccaa4'
- content_length: '0'
- content_type: 'text/plain'
- cseq: '49369392 MESSAGE'
- from: '<sip:testacc@127.0.0.1>;tag=5p9XaaNX4rF6F'
- headers: {'via': ['SIP/2.0/UDP 127.0.0.1:40885;branch=z9hG4bK6y978UBDgKUjj;received=127.0.0.1;rport=40885'], 'max-forwards': ['70'], 'from': ['<sip:testacc@127.0.0.1>;tag=5p9XaaNX4rF6F'], 'to': ['<sip:user@somewhere.com>'], 'call-id': ['3877d784-9a20-1231-f99d-9c4e365ccaa4'], 'cseq': ['49369392 MESSAGE'], 'user-agent': ['Telepathy-Rakia/0.7.5.1 sofia-sip/1.12.11'], 'allow': ['INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, UPDATE'], 'supported': ['timer, 100rel'], 'content-type': ['text/plain'], 'content-length': ['0']}
- max_forwards: '70'
- sip_message: <SIP Request 31576144:MESSAGE sip:user@somewhere.com>
- subqueue: 'sip'
- subtype: 'message'
- supported: 'timer, 100rel'
- to: '<sip:user@somewhere.com>'
- uri: 'sip:user@somewhere.com'
- user_agent: 'Telepathy-Rakia/0.7.5.1 sofia-sip/1.12.11'
- via: 'SIP/2.0/UDP 127.0.0.1:40885;branch=z9hG4bK6y978UBDgKUjj;received=127.0.0.1;rport=40885'
got event:
- type sip-message
- allow: 'INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, UPDATE'
- body: ''
- call_id: '3877d784-9a20-1231-f99d-9c4e365ccaa4'
- content_length: '0'
- content_type: 'text/plain'
- cseq: '49369392 MESSAGE'
- from: '<sip:testacc@127.0.0.1>;tag=5p9XaaNX4rF6F'
- headers: {'via': ['SIP/2.0/UDP 127.0.0.1:40885;branch=z9hG4bK6y978UBDgKUjj;received=127.0.0.1;rport=40885'], 'max-forwards': ['70'], 'from': ['<sip:testacc@127.0.0.1>;tag=5p9XaaNX4rF6F'], 'to': ['<sip:user@somewhere.com>'], 'call-id': ['3877d784-9a20-1231-f99d-9c4e365ccaa4'], 'cseq': ['49369392 MESSAGE'], 'user-agent': ['Telepathy-Rakia/0.7.5.1 sofia-sip/1.12.11'], 'allow': ['INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, UPDATE'], 'supported': ['timer, 100rel'], 'content-type': ['text/plain'], 'content-length': ['0']}
- max_forwards: '70'
- sip_message: <SIP Request 31576144:MESSAGE sip:user@somewhere.com>
- subqueue: 'sip'
- subtype: 'message'
- supported: 'timer, 100rel'
- to: '<sip:user@somewhere.com>'
- uri: 'sip:user@somewhere.com'
- user_agent: 'Telepathy-Rakia/0.7.5.1 sofia-sip/1.12.11'
- via: 'SIP/2.0/UDP 127.0.0.1:40885;branch=z9hG4bK6y978UBDgKUjj;received=127.0.0.1;rport=40885'
not handled

Waiting for event on: sip
Adding to queue
got event:
- type sip-message
- allow: 'INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, UPDATE'
- body: ''
- call_id: '3877d784-9a20-1231-f99d-9c4e365ccaa4'
- content_length: '0'
- content_type: 'text/plain'
- cseq: '49369392 MESSAGE'
- from: '<sip:testacc@127.0.0.1>;tag=5p9XaaNX4rF6F'
- headers: {'via': ['SIP/2.0/UDP 127.0.0.1:40885;branch=z9hG4bK6y978UBDgKUjj;received=127.0.0.1;rport=40885'], 'max-forwards': ['70'], 'from': ['<sip:testacc@127.0.0.1>;tag=5p9XaaNX4rF6F'], 'to': ['<sip:user@somewhere.com>'], 'call-id': ['3877d784-9a20-1231-f99d-9c4e365ccaa4'], 'cseq': ['49369392 MESSAGE'], 'user-agent': ['Telepathy-Rakia/0.7.5.1 sofia-sip/1.12.11'], 'allow': ['INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, UPDATE'], 'supported': ['timer, 100rel'], 'content-type': ['text/plain'], 'content-length': ['0']}
- max_forwards: '70'
- sip_message: <SIP Request 31556816:MESSAGE sip:user@somewhere.com>
- subqueue: 'sip'
- subtype: 'message'
- supported: 'timer, 100rel'
- to: '<sip:user@somewhere.com>'
- uri: 'sip:user@somewhere.com'
- user_agent: 'Telepathy-Rakia/0.7.5.1 sofia-sip/1.12.11'
- via: 'SIP/2.0/UDP 127.0.0.1:40885;branch=z9hG4bK6y978UBDgKUjj;received=127.0.0.1;rport=40885'
got event:
- type sip-message
- allow: 'INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, UPDATE'
- body: ''
- call_id: '3877d784-9a20-1231-f99d-9c4e365ccaa4'
- content_length: '0'
- content_type: 'text/plain'
- cseq: '49369392 MESSAGE'
- from: '<sip:testacc@127.0.0.1>;tag=5p9XaaNX4rF6F'
- headers: {'via': ['SIP/2.0/UDP 127.0.0.1:40885;branch=z9hG4bK6y978UBDgKUjj;received=127.0.0.1;rport=40885'], 'max-forwards': ['70'], 'from': ['<sip:testacc@127.0.0.1>;tag=5p9XaaNX4rF6F'], 'to': ['<sip:user@somewhere.com>'], 'call-id': ['3877d784-9a20-1231-f99d-9c4e365ccaa4'], 'cseq': ['49369392 MESSAGE'], 'user-agent': ['Telepathy-Rakia/0.7.5.1 sofia-sip/1.12.11'], 'allow': ['INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, UPDATE'], 'supported': ['timer, 100rel'], 'content-type': ['text/plain'], 'content-length': ['0']}
- max_forwards: '70'
- sip_message: <SIP Request 31556816:MESSAGE sip:user@somewhere.com>
- subqueue: 'sip'
- subtype: 'message'
- supported: 'timer, 100rel'
- to: '<sip:user@somewhere.com>'
- uri: 'sip:user@somewhere.com'
- user_agent: 'Telepathy-Rakia/0.7.5.1 sofia-sip/1.12.11'
- via: 'SIP/2.0/UDP 127.0.0.1:40885;branch=z9hG4bK6y978UBDgKUjj;received=127.0.0.1;rport=40885'
not handled

Waiting for event on: sip
Adding to queue
got event:
- type sip-message
- allow: 'INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, UPDATE'
- body: ''
- call_id: '3877d784-9a20-1231-f99d-9c4e365ccaa4'
- content_length: '0'
- content_type: 'text/plain'
- cseq: '49369392 MESSAGE'
- from: '<sip:testacc@127.0.0.1>;tag=5p9XaaNX4rF6F'
- headers: {'via': ['SIP/2.0/UDP 127.0.0.1:40885;branch=z9hG4bK6y978UBDgKUjj;received=127.0.0.1;rport=40885'], 'max-forwards': ['70'], 'from': ['<sip:testacc@127.0.0.1>;tag=5p9XaaNX4rF6F'], 'to': ['<sip:user@somewhere.com>'], 'call-id': ['3877d784-9a20-1231-f99d-9c4e365ccaa4'], 'cseq': ['49369392 MESSAGE'], 'user-agent': ['Telepathy-Rakia/0.7.5.1 sofia-sip/1.12.11'], 'allow': ['INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, UPDATE'], 'supported': ['timer, 100rel'], 'content-type': ['text/plain'], 'content-length': ['0']}
- max_forwards: '70'
- sip_message: <SIP Request 31556744:MESSAGE sip:user@somewhere.com>
- subqueue: 'sip'
- subtype: 'message'
- supported: 'timer, 100rel'
- to: '<sip:user@somewhere.com>'
- uri: 'sip:user@somewhere.com'
- user_agent: 'Telepathy-Rakia/0.7.5.1 sofia-sip/1.12.11'
- via: 'SIP/2.0/UDP 127.0.0.1:40885;branch=z9hG4bK6y978UBDgKUjj;received=127.0.0.1;rport=40885'
got event:
- type sip-message
- allow: 'INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, UPDATE'
- body: ''
- call_id: '3877d784-9a20-1231-f99d-9c4e365ccaa4'
- content_length: '0'
- content_type: 'text/plain'
- cseq: '49369392 MESSAGE'
- from: '<sip:testacc@127.0.0.1>;tag=5p9XaaNX4rF6F'
- headers: {'via': ['SIP/2.0/UDP 127.0.0.1:40885;branch=z9hG4bK6y978UBDgKUjj;received=127.0.0.1;rport=40885'], 'max-forwards': ['70'], 'from': ['<sip:testacc@127.0.0.1>;tag=5p9XaaNX4rF6F'], 'to': ['<sip:user@somewhere.com>'], 'call-id': ['3877d784-9a20-1231-f99d-9c4e365ccaa4'], 'cseq': ['49369392 MESSAGE'], 'user-agent': ['Telepathy-Rakia/0.7.5.1 sofia-sip/1.12.11'], 'allow': ['INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, UPDATE'], 'supported': ['timer, 100rel'], 'content-type': ['text/plain'], 'content-length': ['0']}
- max_forwards: '70'
- sip_message: <SIP Request 31556744:MESSAGE sip:user@somewhere.com>
- subqueue: 'sip'
- subtype: 'message'
- supported: 'timer, 100rel'
- to: '<sip:user@somewhere.com>'
- uri: 'sip:user@somewhere.com'
- user_agent: 'Telepathy-Rakia/0.7.5.1 sofia-sip/1.12.11'
- via: 'SIP/2.0/UDP 127.0.0.1:40885;branch=z9hG4bK6y978UBDgKUjj;received=127.0.0.1;rport=40885'
not handled

Waiting for event on: sip
Adding to queue
got event:
- type sip-message
- allow: 'INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, UPDATE'
- body: ''
- call_id: '3877d784-9a20-1231-f99d-9c4e365ccaa4'
- content_length: '0'
- content_type: 'text/plain'
- cseq: '49369392 MESSAGE'
- from: '<sip:testacc@127.0.0.1>;tag=5p9XaaNX4rF6F'
- headers: {'via': ['SIP/2.0/UDP 127.0.0.1:40885;branch=z9hG4bK6y978UBDgKUjj;received=127.0.0.1;rport=40885'], 'max-forwards': ['70'], 'from': ['<sip:testacc@127.0.0.1>;tag=5p9XaaNX4rF6F'], 'to': ['<sip:user@somewhere.com>'], 'call-id': ['3877d784-9a20-1231-f99d-9c4e365ccaa4'], 'cseq': ['49369392 MESSAGE'], 'user-agent': ['Telepathy-Rakia/0.7.5.1 sofia-sip/1.12.11'], 'allow': ['INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, UPDATE'], 'supported': ['timer, 100rel'], 'content-type': ['text/plain'], 'content-length': ['0']}
- max_forwards: '70'
- sip_message: <SIP Request 31556888:MESSAGE sip:user@somewhere.com>
- subqueue: 'sip'
- subtype: 'message'
- supported: 'timer, 100rel'
- to: '<sip:user@somewhere.com>'
- uri: 'sip:user@somewhere.com'
- user_agent: 'Telepathy-Rakia/0.7.5.1 sofia-sip/1.12.11'
- via: 'SIP/2.0/UDP 127.0.0.1:40885;branch=z9hG4bK6y978UBDgKUjj;received=127.0.0.1;rport=40885'
got event:
- type sip-message
- allow: 'INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, UPDATE'
- body: ''
- call_id: '3877d784-9a20-1231-f99d-9c4e365ccaa4'
- content_length: '0'
- content_type: 'text/plain'
- cseq: '49369392 MESSAGE'
- from: '<sip:testacc@127.0.0.1>;tag=5p9XaaNX4rF6F'
- headers: {'via': ['SIP/2.0/UDP 127.0.0.1:40885;branch=z9hG4bK6y978UBDgKUjj;received=127.0.0.1;rport=40885'], 'max-forwards': ['70'], 'from': ['<sip:testacc@127.0.0.1>;tag=5p9XaaNX4rF6F'], 'to': ['<sip:user@somewhere.com>'], 'call-id': ['3877d784-9a20-1231-f99d-9c4e365ccaa4'], 'cseq': ['49369392 MESSAGE'], 'user-agent': ['Telepathy-Rakia/0.7.5.1 sofia-sip/1.12.11'], 'allow': ['INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, UPDATE'], 'supported': ['timer, 100rel'], 'content-type': ['text/plain'], 'content-length': ['0']}
- max_forwards: '70'
- sip_message: <SIP Request 31556888:MESSAGE sip:user@somewhere.com>
- subqueue: 'sip'
- subtype: 'message'
- supported: 'timer, 100rel'
- to: '<sip:user@somewhere.com>'
- uri: 'sip:user@somewhere.com'
- user_agent: 'Telepathy-Rakia/0.7.5.1 sofia-sip/1.12.11'
- via: 'SIP/2.0/UDP 127.0.0.1:40885;branch=z9hG4bK6y978UBDgKUjj;received=127.0.0.1;rport=40885'
not handled

Waiting for event on: sip
Adding to queue
got event:
- type sip-message
- allow: 'INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, UPDATE'
- body: ''
- call_id: '3877d784-9a20-1231-f99d-9c4e365ccaa4'
- content_length: '0'
- content_type: 'text/plain'
- cseq: '49369392 MESSAGE'
- from: '<sip:testacc@127.0.0.1>;tag=5p9XaaNX4rF6F'
- headers: {'via': ['SIP/2.0/UDP 127.0.0.1:40885;branch=z9hG4bK6y978UBDgKUjj;received=127.0.0.1;rport=40885'], 'max-forwards': ['70'], 'from': ['<sip:testacc@127.0.0.1>;tag=5p9XaaNX4rF6F'], 'to': ['<sip:user@somewhere.com>'], 'call-id': ['3877d784-9a20-1231-f99d-9c4e365ccaa4'], 'cseq': ['49369392 MESSAGE'], 'user-agent': ['Telepathy-Rakia/0.7.5.1 sofia-sip/1.12.11'], 'allow': ['INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, UPDATE'], 'supported': ['timer, 100rel'], 'content-type': ['text/plain'], 'content-length': ['0']}
- max_forwards: '70'
- sip_message: <SIP Request 31556816:MESSAGE sip:user@somewhere.com>
- subqueue: 'sip'
- subtype: 'message'
- supported: 'timer, 100rel'
- to: '<sip:user@somewhere.com>'
- uri: 'sip:user@somewhere.com'
- user_agent: 'Telepathy-Rakia/0.7.5.1 sofia-sip/1.12.11'
- via: 'SIP/2.0/UDP 127.0.0.1:40885;branch=z9hG4bK6y978UBDgKUjj;received=127.0.0.1;rport=40885'
got event:
- type sip-message
- allow: 'INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, UPDATE'
- body: ''
- call_id: '3877d784-9a20-1231-f99d-9c4e365ccaa4'
- content_length: '0'
- content_type: 'text/plain'
- cseq: '49369392 MESSAGE'
- from: '<sip:testacc@127.0.0.1>;tag=5p9XaaNX4rF6F'
- headers: {'via': ['SIP/2.0/UDP 127.0.0.1:40885;branch=z9hG4bK6y978UBDgKUjj;received=127.0.0.1;rport=40885'], 'max-forwards': ['70'], 'from': ['<sip:testacc@127.0.0.1>;tag=5p9XaaNX4rF6F'], 'to': ['<sip:user@somewhere.com>'], 'call-id': ['3877d784-9a20-1231-f99d-9c4e365ccaa4'], 'cseq': ['49369392 MESSAGE'], 'user-agent': ['Telepathy-Rakia/0.7.5.1 sofia-sip/1.12.11'], 'allow': ['INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, UPDATE'], 'supported': ['timer, 100rel'], 'content-type': ['text/plain'], 'content-length': ['0']}
- max_forwards: '70'
- sip_message: <SIP Request 31556816:MESSAGE sip:user@somewhere.com>
- subqueue: 'sip'
- subtype: 'message'
- supported: 'timer, 100rel'
- to: '<sip:user@somewhere.com>'
- uri: 'sip:user@somewhere.com'
- user_agent: 'Telepathy-Rakia/0.7.5.1 sofia-sip/1.12.11'
- via: 'SIP/2.0/UDP 127.0.0.1:40885;branch=z9hG4bK6y978UBDgKUjj;received=127.0.0.1;rport=40885'
not handled

Waiting for event on: sip
Adding to queue
got event:
- type sip-message
- allow: 'INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, UPDATE'
- body: ''
- call_id: '3877d784-9a20-1231-f99d-9c4e365ccaa4'
- content_length: '0'
- content_type: 'text/plain'
- cseq: '49369392 MESSAGE'
- from: '<sip:testacc@127.0.0.1>;tag=5p9XaaNX4rF6F'
- headers: {'via': ['SIP/2.0/UDP 127.0.0.1:40885;branch=z9hG4bK6y978UBDgKUjj;received=127.0.0.1;rport=40885'], 'max-forwards': ['70'], 'from': ['<sip:testacc@127.0.0.1>;tag=5p9XaaNX4rF6F'], 'to': ['<sip:user@somewhere.com>'], 'call-id': ['3877d784-9a20-1231-f99d-9c4e365ccaa4'], 'cseq': ['49369392 MESSAGE'], 'user-agent': ['Telepathy-Rakia/0.7.5.1 sofia-sip/1.12.11'], 'allow': ['INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, UPDATE'], 'supported': ['timer, 100rel'], 'content-type': ['text/plain'], 'content-length': ['0']}
- max_forwards: '70'
- sip_message: <SIP Request 31559336:MESSAGE sip:user@somewhere.com>
- subqueue: 'sip'
- subtype: 'message'
- supported: 'timer, 100rel'
- to: '<sip:user@somewhere.com>'
- uri: 'sip:user@somewhere.com'
- user_agent: 'Telepathy-Rakia/0.7.5.1 sofia-sip/1.12.11'
- via: 'SIP/2.0/UDP 127.0.0.1:40885;branch=z9hG4bK6y978UBDgKUjj;received=127.0.0.1;rport=40885'
got event:
- type sip-message
- allow: 'INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, UPDATE'
- body: ''
- call_id: '3877d784-9a20-1231-f99d-9c4e365ccaa4'
- content_length: '0'
- content_type: 'text/plain'
- cseq: '49369392 MESSAGE'
- from: '<sip:testacc@127.0.0.1>;tag=5p9XaaNX4rF6F'
- headers: {'via': ['SIP/2.0/UDP 127.0.0.1:40885;branch=z9hG4bK6y978UBDgKUjj;received=127.0.0.1;rport=40885'], 'max-forwards': ['70'], 'from': ['<sip:testacc@127.0.0.1>;tag=5p9XaaNX4rF6F'], 'to': ['<sip:user@somewhere.com>'], 'call-id': ['3877d784-9a20-1231-f99d-9c4e365ccaa4'], 'cseq': ['49369392 MESSAGE'], 'user-agent': ['Telepathy-Rakia/0.7.5.1 sofia-sip/1.12.11'], 'allow': ['INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, UPDATE'], 'supported': ['timer, 100rel'], 'content-type': ['text/plain'], 'content-length': ['0']}
- max_forwards: '70'
- sip_message: <SIP Request 31559336:MESSAGE sip:user@somewhere.com>
- subqueue: 'sip'
- subtype: 'message'
- supported: 'timer, 100rel'
- to: '<sip:user@somewhere.com>'
- uri: 'sip:user@somewhere.com'
- user_agent: 'Telepathy-Rakia/0.7.5.1 sofia-sip/1.12.11'
- via: 'SIP/2.0/UDP 127.0.0.1:40885;branch=z9hG4bK6y978UBDgKUjj;received=127.0.0.1;rport=40885'
not handled

Waiting for event on: sip
Adding to queue
got event:
- type sip-message
- allow: 'INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, UPDATE'
- body: ''
- call_id: '3877d784-9a20-1231-f99d-9c4e365ccaa4'
- content_length: '0'
- content_type: 'text/plain'
- cseq: '49369392 MESSAGE'
- from: '<sip:testacc@127.0.0.1>;tag=5p9XaaNX4rF6F'
- headers: {'via': ['SIP/2.0/UDP 127.0.0.1:40885;branch=z9hG4bK6y978UBDgKUjj;received=127.0.0.1;rport=40885'], 'max-forwards': ['70'], 'from': ['<sip:testacc@127.0.0.1>;tag=5p9XaaNX4rF6F'], 'to': ['<sip:user@somewhere.com>'], 'call-id': ['3877d784-9a20-1231-f99d-9c4e365ccaa4'], 'cseq': ['49369392 MESSAGE'], 'user-agent': ['Telepathy-Rakia/0.7.5.1 sofia-sip/1.12.11'], 'allow': ['INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, UPDATE'], 'supported': ['timer, 100rel'], 'content-type': ['text/plain'], 'content-length': ['0']}
- max_forwards: '70'
- sip_message: <SIP Request 31556888:MESSAGE sip:user@somewhere.com>
- subqueue: 'sip'
- subtype: 'message'
- supported: 'timer, 100rel'
- to: '<sip:user@somewhere.com>'
- uri: 'sip:user@somewhere.com'
- user_agent: 'Telepathy-Rakia/0.7.5.1 sofia-sip/1.12.11'
- via: 'SIP/2.0/UDP 127.0.0.1:40885;branch=z9hG4bK6y978UBDgKUjj;received=127.0.0.1;rport=40885'
got event:
- type sip-message
- allow: 'INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, UPDATE'
- body: ''
- call_id: '3877d784-9a20-1231-f99d-9c4e365ccaa4'
- content_length: '0'
- content_type: 'text/plain'
- cseq: '49369392 MESSAGE'
- from: '<sip:testacc@127.0.0.1>;tag=5p9XaaNX4rF6F'
- headers: {'via': ['SIP/2.0/UDP 127.0.0.1:40885;branch=z9hG4bK6y978UBDgKUjj;received=127.0.0.1;rport=40885'], 'max-forwards': ['70'], 'from': ['<sip:testacc@127.0.0.1>;tag=5p9XaaNX4rF6F'], 'to': ['<sip:user@somewhere.com>'], 'call-id': ['3877d784-9a20-1231-f99d-9c4e365ccaa4'], 'cseq': ['49369392 MESSAGE'], 'user-agent': ['Telepathy-Rakia/0.7.5.1 sofia-sip/1.12.11'], 'allow': ['INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, UPDATE'], 'supported': ['timer, 100rel'], 'content-type': ['text/plain'], 'content-length': ['0']}
- max_forwards: '70'
- sip_message: <SIP Request 31556888:MESSAGE sip:user@somewhere.com>
- subqueue: 'sip'
- subtype: 'message'
- supported: 'timer, 100rel'
- to: '<sip:user@somewhere.com>'
- uri: 'sip:user@somewhere.com'
- user_agent: 'Telepathy-Rakia/0.7.5.1 sofia-sip/1.12.11'
- via: 'SIP/2.0/UDP 127.0.0.1:40885;branch=z9hG4bK6y978UBDgKUjj;received=127.0.0.1;rport=40885'
not handled

Waiting for event on: sip
Adding to queue
got event:
- type sip-message
- allow: 'INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, UPDATE'
- body: ''
- call_id: '3877d784-9a20-1231-f99d-9c4e365ccaa4'
- content_length: '0'
- content_type: 'text/plain'
- cseq: '49369392 MESSAGE'
- from: '<sip:testacc@127.0.0.1>;tag=5p9XaaNX4rF6F'
- headers: {'via': ['SIP/2.0/UDP 127.0.0.1:40885;branch=z9hG4bK6y978UBDgKUjj;received=127.0.0.1;rport=40885'], 'max-forwards': ['70'], 'from': ['<sip:testacc@127.0.0.1>;tag=5p9XaaNX4rF6F'], 'to': ['<sip:user@somewhere.com>'], 'call-id': ['3877d784-9a20-1231-f99d-9c4e365ccaa4'], 'cseq': ['49369392 MESSAGE'], 'user-agent': ['Telepathy-Rakia/0.7.5.1 sofia-sip/1.12.11'], 'allow': ['INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, UPDATE'], 'supported': ['timer, 100rel'], 'content-type': ['text/plain'], 'content-length': ['0']}
- max_forwards: '70'
- sip_message: <SIP Request 31556816:MESSAGE sip:user@somewhere.com>
- subqueue: 'sip'
- subtype: 'message'
- supported: 'timer, 100rel'
- to: '<sip:user@somewhere.com>'
- uri: 'sip:user@somewhere.com'
- user_agent: 'Telepathy-Rakia/0.7.5.1 sofia-sip/1.12.11'
- via: 'SIP/2.0/UDP 127.0.0.1:40885;branch=z9hG4bK6y978UBDgKUjj;received=127.0.0.1;rport=40885'
got event:
- type sip-message
- allow: 'INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, UPDATE'
- body: ''
- call_id: '3877d784-9a20-1231-f99d-9c4e365ccaa4'
- content_length: '0'
- content_type: 'text/plain'
- cseq: '49369392 MESSAGE'
- from: '<sip:testacc@127.0.0.1>;tag=5p9XaaNX4rF6F'
- headers: {'via': ['SIP/2.0/UDP 127.0.0.1:40885;branch=z9hG4bK6y978UBDgKUjj;received=127.0.0.1;rport=40885'], 'max-forwards': ['70'], 'from': ['<sip:testacc@127.0.0.1>;tag=5p9XaaNX4rF6F'], 'to': ['<sip:user@somewhere.com>'], 'call-id': ['3877d784-9a20-1231-f99d-9c4e365ccaa4'], 'cseq': ['49369392 MESSAGE'], 'user-agent': ['Telepathy-Rakia/0.7.5.1 sofia-sip/1.12.11'], 'allow': ['INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, UPDATE'], 'supported': ['timer, 100rel'], 'content-type': ['text/plain'], 'content-length': ['0']}
- max_forwards: '70'
- sip_message: <SIP Request 31556816:MESSAGE sip:user@somewhere.com>
- subqueue: 'sip'
- subtype: 'message'
- supported: 'timer, 100rel'
- to: '<sip:user@somewhere.com>'
- uri: 'sip:user@somewhere.com'
- user_agent: 'Telepathy-Rakia/0.7.5.1 sofia-sip/1.12.11'
- via: 'SIP/2.0/UDP 127.0.0.1:40885;branch=z9hG4bK6y978UBDgKUjj;received=127.0.0.1;rport=40885'
not handled

Waiting for event on: sip
Adding to queue
got event:
- type sip-message
- allow: 'INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, UPDATE'
- body: ''
- call_id: '3877d784-9a20-1231-f99d-9c4e365ccaa4'
- content_length: '0'
- content_type: 'text/plain'
- cseq: '49369392 MESSAGE'
- from: '<sip:testacc@127.0.0.1>;tag=5p9XaaNX4rF6F'
- headers: {'via': ['SIP/2.0/UDP 127.0.0.1:40885;branch=z9hG4bK6y978UBDgKUjj;received=127.0.0.1;rport=40885'], 'max-forwards': ['70'], 'from': ['<sip:testacc@127.0.0.1>;tag=5p9XaaNX4rF6F'], 'to': ['<sip:user@somewhere.com>'], 'call-id': ['3877d784-9a20-1231-f99d-9c4e365ccaa4'], 'cseq': ['49369392 MESSAGE'], 'user-agent': ['Telepathy-Rakia/0.7.5.1 sofia-sip/1.12.11'], 'allow': ['INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, UPDATE'], 'supported': ['timer, 100rel'], 'content-type': ['text/plain'], 'content-length': ['0']}
- max_forwards: '70'
- sip_message: <SIP Request 31559336:MESSAGE sip:user@somewhere.com>
- subqueue: 'sip'
- subtype: 'message'
- supported: 'timer, 100rel'
- to: '<sip:user@somewhere.com>'
- uri: 'sip:user@somewhere.com'
- user_agent: 'Telepathy-Rakia/0.7.5.1 sofia-sip/1.12.11'
- via: 'SIP/2.0/UDP 127.0.0.1:40885;branch=z9hG4bK6y978UBDgKUjj;received=127.0.0.1;rport=40885'
got event:
- type sip-message
- allow: 'INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, UPDATE'
- body: ''
- call_id: '3877d784-9a20-1231-f99d-9c4e365ccaa4'
- content_length: '0'
- content_type: 'text/plain'
- cseq: '49369392 MESSAGE'
- from: '<sip:testacc@127.0.0.1>;tag=5p9XaaNX4rF6F'
- headers: {'via': ['SIP/2.0/UDP 127.0.0.1:40885;branch=z9hG4bK6y978UBDgKUjj;received=127.0.0.1;rport=40885'], 'max-forwards': ['70'], 'from': ['<sip:testacc@127.0.0.1>;tag=5p9XaaNX4rF6F'], 'to': ['<sip:user@somewhere.com>'], 'call-id': ['3877d784-9a20-1231-f99d-9c4e365ccaa4'], 'cseq': ['49369392 MESSAGE'], 'user-agent': ['Telepathy-Rakia/0.7.5.1 sofia-sip/1.12.11'], 'allow': ['INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, UPDATE'], 'supported': ['timer, 100rel'], 'content-type': ['text/plain'], 'content-length': ['0']}
- max_forwards: '70'
- sip_message: <SIP Request 31559336:MESSAGE sip:user@somewhere.com>
- subqueue: 'sip'
- subtype: 'message'
- supported: 'timer, 100rel'
- to: '<sip:user@somewhere.com>'
- uri: 'sip:user@somewhere.com'
- user_agent: 'Telepathy-Rakia/0.7.5.1 sofia-sip/1.12.11'
- via: 'SIP/2.0/UDP 127.0.0.1:40885;branch=z9hG4bK6y978UBDgKUjj;received=127.0.0.1;rport=40885'
not handled

Waiting for event on: sip
Adding to queue
got event:
- type dbus-signal
- args: [0L, 1379410943L, 2L, 4L, 2L, u'']
- interface: 'org.freedesktop.Telepathy.Channel.Type.Text'
- path: '/org/freedesktop/Telepathy/Connection/sofiasip/sip/testacc_40127_2e0_2e0_2e1/TextChannel2'
- signal: 'Received'
- subqueue: 'dbus'
- subtype: 'signal'
Adding to queue
got event:
- type dbus-signal
- args: [[{u'delivery-dbus-error': u'org.freedesktop.Telepathy.Error.InvalidArgument',
   u'delivery-status': 3L,
   u'delivery-token': u'0',
   u'message-received': 1379410943L,
   u'message-sender': 2L,
   u'message-sender-id': u'sip:user@somewhere.com',
   u'message-type': 4L,
   u'pending-message-id': 0L}]]
- interface: 'org.freedesktop.Telepathy.Channel.Interface.Messages'
- path: '/org/freedesktop/Telepathy/Connection/sofiasip/sip/testacc_40127_2e0_2e0_2e1/TextChannel2'
- signal: 'MessageReceived'
- subqueue: 'dbus'
- subtype: 'signal'
Adding to queue
got event:
- type dbus-signal
- args: [0L, 0L, 0L, u'']
- interface: 'org.freedesktop.Telepathy.Channel.Type.Text'
- path: '/org/freedesktop/Telepathy/Connection/sofiasip/sip/testacc_40127_2e0_2e0_2e1/TextChannel2'
- signal: 'SendError'
- subqueue: 'dbus'
- subtype: 'signal'
Traceback (most recent call last):
  File "/home/cassidy/dev/telepathy-rakia/tests/twisted/test-message.py", line 244, in <module>
    exec_test(test)
  File "/home/cassidy/dev/telepathy-rakia/tests/twisted/sofiatest.py", line 148, in exec_test
    fun(queue, bus, conn, sip)
  File "/home/cassidy/dev/telepathy-rakia/tests/twisted/test-message.py", line 79, in test
    event = q.expect('sip-message', uri='sip:user@somewhere.com', body='Hello')
  File "/home/cassidy/dev/telepathy-rakia/tests/twisted/servicetest.py", line 146, in expect
    event = self.wait([pattern.subqueue])
  File "/home/cassidy/dev/telepathy-rakia/tests/twisted/servicetest.py", line 280, in wait
    raise TimeoutError
servicetest.TimeoutError
FAIL: test-message.py (1)
make: *** [check-twisted] Erreur 1

Comment 2 Simon McVittie 2013-11-11 19:19:20 UTC

This looks a lot like Bug #71504. Which distribution? Which sofia-sip version?

Comment 3 Simon McVittie 2013-11-11 19:19:31 UTC

*** Bug 71504 has been marked as a duplicate of this bug. ***

Comment 4 Simon McVittie 2013-11-11 19:20:58 UTC

For Debian users (or at least for me, on jessie/sid amd64), a workaround is to downgrade sofia-sip from 1.12.11+20110422.1-1 to 1.12.11+20110422-1. See Bug #71504 and <http://bugs.debian.org/cgi-bin/bugreport.cgi?bug=729301>.

Comment 5 Simon McVittie 2014-01-29 11:29:12 UTC

This is a sofia-sip bug: http://sourceforge.net/p/sofia-sip/bugs/121/

Fixed in Debian: http://bugs.debian.org/cgi-bin/bugreport.cgi?bug=729301#32

The same patch doesn't seem to have been sufficient to fix it in Fedora for some reason; please send feedback to <https://bugzilla.redhat.com/show_bug.cgi?id=981056>. If you find more miscompilations, please tell the upstream bug.

Comment 6 Guillaume Desmottes 2014-01-29 14:05:10 UTC

I manually built sofia-sip master on my Fedora 20 and that solved it as well.

Use of freedesktop.org services, including Bugzilla, is subject to our Code of Conduct. How we collect and use information is described in our Privacy Policy.