twisted errors for video and audio encoders

Bug #1016832 reported by Robbert Muller
6
This bug affects 1 person
Affects Status Importance Assigned to Milestone
Flumotion
Fix Released
Unknown
flumotion (Debian)
Fix Released
Unknown
flumotion (Ubuntu)
New
Undecided
Unassigned

Bug Description

I get a lot of twisted exceptions in the logfiles and the encoder seems not to be working

Created for testing and reporting a ogg video stream with the assistant. just video no audio, no overlays, ogg encoding but selecting other formats and encodings doens't change the problem

Release: 12.04
# apt-cache policy flumotion
flumotion:
  Installed: 0.10.0-1
  Candidate: 0.10.0-1
  Version table:
 *** 0.10.0-1 0
        500 http://archive.ubuntu.com/ubuntu/ precise/universe amd64 Packages
        100 /var/lib/dpkg/status

Config:
<?xml version="1.0" encoding="UTF-8"?>
<planet name="planet">

  <atmosphere>
    <component name="http-server-video"
               type="http-server"
               label="http-server-video"
               worker="localhost"
               project="flumotion"
               version="0.10.0">
      <property name="porter-username">*hide*</property>
      <property name="mount-point">/ogg-video/html5/</property>
      <property name="hostname">*hide*</property>
      <property name="porter-password">*hide*</property>
      <property name="type">slave</property>
      <property name="porter-socket-path">flu-LgXlxL.socket</property>
      <property name="port">8800</property>
      <plugs>
        <plug type="component-html5">
          <property name="width">320</property>
          <property name="stream-url">http://*hide*:8800/ogg-video/</property>
          <property name="codecs">theora</property>
          <property name="mime-type">video/ogg</property>
          <property name="height">240</property>
        </plug>
      </plugs>
    </component>

    <component name="porter-http"
               type="porter"
               label="porter-http"
               worker="localhost"
               project="flumotion"
               version="0.10.0">
      <property name="username">*hide*</property>
      <property name="socket-path">flu-LgXlxL.socket</property>
      <property name="password">*hide*</property>
      <property name="port">8800</property>
    </component>

  </atmosphere>

  <flow name="default">
    <component name="producer-video"
               type="videotest-producer"
               label="producer-video"
               worker="localhost"
               project="flumotion"
               version="0.10.0">
      <property name="pattern">0</property>
      <property name="height">240</property>
      <property name="framerate">5/1</property>
      <property name="width">320</property>
      <clock-master>true</clock-master>
    </component>

    <component name="encoder-video"
               type="theora-encoder"
               label="encoder-video"
               worker="localhost"
               project="flumotion"
               version="0.10.0">
      <eater name="default">
        <feed alias="default">producer-video:default</feed>
      </eater>
      <property name="keyframe-maxdistance">10</property>
      <property name="speed">3</property>
      <property name="bitrate">400000</property>
      <clock-master>false</clock-master>
    </component>

    <component name="muxer-video"
               type="ogg-muxer"
               label="muxer-video"
               worker="localhost"
               project="flumotion"
               version="0.10.0">
      <eater name="default">
        <feed alias="default">encoder-video:default</feed>
      </eater>
      <clock-master>false</clock-master>
    </component>

    <component name="http-video"
               type="http-streamer"
               label="http-video"
               worker="localhost"
               project="flumotion"
               version="0.10.0">
      <eater name="default">
        <feed alias="default">muxer-video:default</feed>
      </eater>
      <property name="burst-on-connect">False</property>
      <property name="porter-username">*hide*</property>
      <property name="mount-point">/ogg-video/</property>
      <property name="port">8800</property>
      <property name="type">slave</property>
      <property name="porter-socket-path">flu-LgXlxL.socket</property>
      <property name="porter-password">*hide*</property>
      <clock-master>false</clock-master>
      <plugs>
      </plugs>
    </component>

  </flow>

</planet>

Log:
DEBUG [ 2106] "http-video" / cons-http Jun 23 10:27:23 FeedComponent.do_setup(): setup finished (flumotion/component/feedcomponent010.py:127)
DEBUG [ 2106] "http-video" cons-http Jun 23 10:27:23 eater default not yet connected, deferring set to PLAYING (flumotion/component/feedcomponent010.py:601)
DEBUG [ 2106] Jun 23 10:27:23 calling <unbound method Streamer.do_setup> (flumotion/component/component.py:145)
INFO [ 2106] "http-video" cons-http Jun 23 10:27:23 Starting porter login at "flu-LgXlxL.socket" (flumotion/component/common/streamer/streamer.py:625)
DEBUG [ 2106] "http-video" cons-http Jun 23 10:27:23 setup completed (flumotion/component/component.py:579)
DEBUG [ 2106] "http-video" cons-http Jun 23 10:27:23 Setup completed (flumotion/component/feedcomponent010.py:138)
DEBUG [ 2106] reflectcall Jun 23 10:27:23 returning <MultifdSinkStreamer (http-video)> (flumotion/common/reflectcall.py:100)
DEBUG [ 2106] "/default/http-video" jobmedium Jun 23 10:27:23 creating ComponentClientFactory (flumotion/job/job.py:285)
DEBUG [ 2106] "/default/http-video" jobmedium Jun 23 10:27:23 created ComponentClientFactory <flumotion.component.component.ComponentClientFactory instance at 0x281f098> (flumotion/job/job.py:288)
DEBUG [ 2106] "/default/http-video" jobmedium Jun 23 10:27:23 logging in with authenticator <flumotion.twisted.pb.RemoteAuthenticator instance at 0x2786050> (flumotion/job/job.py:295)
DEBUG [ 2107] "muxer-video" component Jun 23 10:27:23 login successful, returning <twisted.spread.pb.RemoteReference instance at 0x2864ab8> (flumotion/twisted/pb.py:179)
INFO [ 2107] "muxer-video" component Jun 23 10:27:23 Logged in to manager (flumotion/component/component.py:87)
DEBUG [ 2107] "muxer-video" component Jun 23 10:27:23 remote reference <twisted.spread.pb.RemoteReference instance at 0x2864ab8> (flumotion/component/component.py:88)
DEBUG [ 2107] "muxer-video" feedcompmed Jun 23 10:27:23 <flumotion.component.feedcomponent.FeedComponentMedium instance at 0x28183b0>.setRemoteReference: <twisted.spread.pb.RemoteReference instance at 0x2864ab8> (flumotion/common/medium.py:65)
DEBUG [ 2107] "muxer-video" feedcompmed Jun 23 10:27:23 connection is from me on 127.0.0.1 to remote on 127.0.0.1 (flumotion/common/medium.py:87)
DEBUG [ 2107] "muxer-video" feedcompmed Jun 23 10:27:23 startPinging (flumotion/common/medium.py:245)
DEBUG [ 2107] "muxer-video" feedcompmed Jun 23 10:27:23 feedserver --> FEEDCOMPMED: remote_eatFrom('default', '/default/encoder-video:default', '127.0.0.1', 8669) (flumotion/component/feedcomponent.py:110)
DEBUG [ 2107] feedclient Jun 23 10:27:23 perspectiveInterface is <InterfaceClass flumotion.common.interfaces.IFeedMedium> (flumotion/twisted/pb.py:126)
INFO [ 2106] "/default/http-video" jobmedium Jun 23 10:27:23 Connecting to manager localhost:7531 with SSL (flumotion/job/job.py:300)
DEBUG [ 2106] "/default/http-video" jobmedium Jun 23 10:27:23 jobavatar <-- JOBMEDIUM: remote_create('/default/http-video', 'http-streamer', 'flumotion.component.consumers.httpstreamer.httpstreamer', 'HTTPStreamer', 0, {'feed': [], 'virtual-feeds': {}, 'name': 'http-video', 'par ... ig-version': 2}): 'None' (flumotion/job/job.py:150)
DEBUG [ 2089] workermedium Jun 23 10:27:23 baseavatar --> WORKERMEDIUM: callRemote(getKeycardClasses, ) (flumotion/common/medium.py:283)
DEBUG [ 2089] "/default/http-video" job-avatar Jun 23 10:27:23 remote <-- COMPONENTJOBAVATAR: callRemote(create, '/default/http-video', 'http-streamer', 'flumotion.component.consumers.httpstreamer.httpstreamer', 'HTTPStreamer', 0, {'feed': [], 'virtual-feeds': {}, 'name': 'http-video', 'par ... ig-version': 2}): 'None' (flumotion/twisted/pb.py:751)
DEBUG [ 2089] "/default/http-video" job-avatar Jun 23 10:27:23 job started component with avatarId /default/http-video (flumotion/worker/job.py:54)
DEBUG [ 2089] default Jun 23 10:27:23 triggering create deferred for /default/http-video (flumotion/common/startset.py:119)
DEBUG [ 2089] workerbrain Jun 23 10:27:23 create deferred for /default/http-video succeeded ('/default/http-video') (flumotion/worker/worker.py:266)
DEBUG [ 2089] workermedium Jun 23 10:27:23 baseavatar <-- WORKERMEDIUM: remote_create('/default/http-video', 'http-streamer', 'flumotion.component.consumers.httpstreamer.httpstreamer', 'HTTPStreamer', 0, {'feed': [], 'virtual-feeds': {}, 'name': 'http-video', 'par ... ig-version': 2}): "'/default/http-video'" (flumotion/worker/medium.py:188)
DEBUG [ 2106] default Jun 23 10:27:23 Got deferred login, adding callbacks (flumotion/component/misc/porter/porterclient.py:170)
DEBUG [ 2106] default Jun 23 10:27:23 Registering mount point /ogg-video/ with porter (flumotion/component/misc/porter/porterclient.py:175)
DEBUG [ 2103] credchecker Jun 23 10:27:23 authenticating user GcJcivghnUNv (flumotion/twisted/checkers.py:74)
DEBUG [ 2106] basemedium Jun 23 10:27:23 <flumotion.component.misc.porter.porterclient.PorterMedium instance at 0x298a050>.setRemoteReference: <twisted.spread.pb.RemoteReference instance at 0x2996d88> (flumotion/common/medium.py:65)
DEBUG [ 2106] basemedium Jun 23 10:27:23 connection is from me on localhost to remote on localhost (flumotion/common/medium.py:87)
DEBUG [ 2106] basemedium Jun 23 10:27:23 baseavatar --> PORTERMEDIUM: callRemote(getPort, ) (flumotion/common/medium.py:151)
DEBUG [ 2106] basemedium Jun 23 10:27:23 baseavatar <-- PORTERMEDIUM: callRemote(getPort, ): 8800 (flumotion/common/medium.py:151)
DEBUG [ 2106] basemedium Jun 23 10:27:23 baseavatar --> PORTERMEDIUM: callRemote(registerPath, '/ogg-video/') (flumotion/common/medium.py:151)
DEBUG [ 2089] workermedium Jun 23 10:27:23 baseavatar <-- WORKERMEDIUM: callRemote(getKeycardClasses, ): ['flumotion.common.keycards.KeycardUACPCC', 'flumotion.common.keycards.KeycardUACPP'] (flumotion/common/medium.py:283)
DEBUG [ 2103] "porter-http" basecomp Jun 23 10:27:23 Registering porter path "/ogg-video/" to <flumotion.component.misc.porter.porter.PorterAvatar instance at 0x32def80> (flumotion/component/misc/porter/porter.py:157)
DEBUG [ 2106] basemedium Jun 23 10:27:23 baseavatar <-- PORTERMEDIUM: callRemote(registerPath, '/ogg-video/'): None (flumotion/common/medium.py:151)
DEBUG [ 2106] default Jun 23 10:27:23 Firing initial deferred: should indicate that login is complete (flumotion/component/misc/porter/porterclient.py:160)
DEBUG [ 2106] "http-video" component Jun 23 10:27:23 perspectiveInterface is <InterfaceClass flumotion.common.interfaces.IComponentMedium> (flumotion/twisted/pb.py:126)
DEBUG [ 2089] authenticator Jun 23 10:27:23 Issuing keycard <KeycardUACPCC None *hide*@localhost for requesterId None in state REQUESTING> of class KeycardUACPCC (flumotion/twisted/pb.py:455)
DEBUG [ 2106] "http-video" component Jun 23 10:27:23 using keycard: <KeycardUACPCC None *hide*@localhost for requesterId None in state REQUESTING> (flumotion/twisted/pb.py:142)
DEBUG [ 2089] authenticator Jun 23 10:27:23 responding to challenge on keycard <KeycardUACPCC 20120623102653-8 *hide*@127.0.0.1 for requesterId None in state REQUESTING> (flumotion/twisted/pb.py:495)
DEBUG [ 2106] "http-video" feedcompmed Jun 23 10:27:23 feedserver --> FEEDCOMPMED: remote_getConfig() (flumotion/component/component.py:244)
DEBUG [ 2106] "http-video" feedcompmed Jun 23 10:27:23 feedserver <-- FEEDCOMPMED: remote_getConfig(): "{'feed': [], 'virtual-feeds': {}, 'name': 'http-video', 'par ... ig-version': 2}" (flumotion/component/component.py:244)
DEBUG [ 2106] "http-video" feedcompmed Jun 23 10:27:23 feedserver --> FEEDCOMPMED: remote_getState() (flumotion/component/component.py:231)
DEBUG [ 2106] "http-video" feedcompmed Jun 23 10:27:23 getManagerIP(): we think the manager's IP is '127.0.0.1' (flumotion/component/component.py:202)
DEBUG [ 2106] "http-video" feedcompmed Jun 23 10:27:23 feedserver <-- FEEDCOMPMED: remote_getState(): '<flumotion.common.planet.WorkerJobState instance at 0x2786ef0>' (flumotion/component/component.py:231)
DEBUG [ 2106] "http-video" feedcompmed Jun 23 10:27:23 feedserver --> FEEDCOMPMED: remote_getMasterClockInfo() (flumotion/component/feedcomponent.py:238)
DEBUG [ 2106] "http-video" feedcompmed Jun 23 10:27:23 feedserver <-- FEEDCOMPMED: remote_getMasterClockInfo(): 'None' (flumotion/component/feedcomponent.py:238)
DEBUG [ 2089] authenticator Jun 23 10:27:23 Issuing keycard <KeycardUACPCC None *hide*@localhost for requesterId None in state REQUESTING> of class KeycardUACPCC (flumotion/twisted/pb.py:455)
DEBUG [ 2107] feedclient Jun 23 10:27:23 using keycard: <KeycardUACPCC None *hide*@localhost for requesterId None in state REQUESTING> (flumotion/twisted/pb.py:142)
DEBUG [ 2106] "http-video" component Jun 23 10:27:23 login successful, returning <twisted.spread.pb.RemoteReference instance at 0x29a2248> (flumotion/twisted/pb.py:179)
INFO [ 2106] "http-video" component Jun 23 10:27:23 Logged in to manager (flumotion/component/component.py:87)
DEBUG [ 2106] "http-video" component Jun 23 10:27:23 remote reference <twisted.spread.pb.RemoteReference instance at 0x29a2248> (flumotion/component/component.py:88)
DEBUG [ 2106] "http-video" feedcompmed Jun 23 10:27:23 <flumotion.component.common.streamer.streamer.HTTPMedium instance at 0x298a1b8>.setRemoteReference: <twisted.spread.pb.RemoteReference instance at 0x29a2248> (flumotion/common/medium.py:65)
DEBUG [ 2106] "http-video" feedcompmed Jun 23 10:27:23 connection is from me on 127.0.0.1 to remote on 127.0.0.1 (flumotion/common/medium.py:87)
DEBUG [ 2106] "http-video" feedcompmed Jun 23 10:27:23 startPinging (flumotion/common/medium.py:245)
DEBUG [ 2106] "http-video" feedcompmed Jun 23 10:27:23 feedserver --> FEEDCOMPMED: remote_eatFrom('default', '/default/muxer-video:default', '127.0.0.1', 8669) (flumotion/component/feedcomponent.py:110)
DEBUG [ 2089] BouncerPortal Jun 23 10:27:23 _login(keycard=<KeycardUACPCC None *hide*@localhost for requesterId None in state REQUESTING>, mind=<twisted.spread.pb.RemoteReference instance at 0x16d88c0>, ifaces=(<InterfaceClass flumotion.common.interfaces.IFeedMedium>, <InterfaceClass twisted.spread.pb.IPerspective>)) (flumotion/twisted/portal.py:86)
DEBUG [ 2089] proxybouncer Jun 23 10:27:23 Authenticating keycard <KeycardUACPCC None *hide*@127.0.0.1 for requesterId None in state REQUESTING> against remote bouncer (flumotion/worker/worker.py:56)
DEBUG [ 2106] feedclient Jun 23 10:27:23 perspectiveInterface is <InterfaceClass flumotion.common.interfaces.IFeedMedium> (flumotion/twisted/pb.py:126)
DEBUG [ 2089] workermedium Jun 23 10:27:23 baseavatar --> WORKERMEDIUM: callRemote(authenticate, None, <KeycardUACPCC None *hide*@127.0.0.1 for requesterId None in state REQUESTING>) (flumotion/common/medium.py:283)
DEBUG [ 2089] workermedium Jun 23 10:27:23 baseavatar --> WORKERMEDIUM: callRemote(getKeycardClasses, ) (flumotion/common/medium.py:283)
DEBUG [ 2089] workermedium Jun 23 10:27:23 baseavatar <-- WORKERMEDIUM: callRemote(authenticate, None, <KeycardUACPCC None *hide*@127.0.0.1 for requesterId None in state REQUESTING>): <KeycardUACPCC 20120623102653-9 *hide*@127.0.0.1 for requesterId None in state REQUESTING> (flumotion/common/medium.py:283)
DEBUG [ 2089] authenticator Jun 23 10:27:23 responding to challenge on keycard <KeycardUACPCC 20120623102653-9 *hide*@127.0.0.1 for requesterId None in state REQUESTING> (flumotion/twisted/pb.py:495)
DEBUG [ 2089] BouncerPortal Jun 23 10:27:23 _login(keycard=<KeycardUACPCC 20120623102653-9 *hide*@127.0.0.1 for requesterId None in state REQUESTING>, mind=<twisted.spread.pb.RemoteReference instance at 0x18a99e0>, ifaces=(<InterfaceClass flumotion.common.interfaces.IFeedMedium>, <InterfaceClass twisted.spread.pb.IPerspective>)) (flumotion/twisted/portal.py:86)
DEBUG [ 2089] proxybouncer Jun 23 10:27:23 Authenticating keycard <KeycardUACPCC 20120623102653-9 *hid*@127.0.0.1 for requesterId None in state REQUESTING> against remote bouncer (flumotion/worker/worker.py:56)
DEBUG [ 2089] workermedium Jun 23 10:27:23 baseavatar --> WORKERMEDIUM: callRemote(authenticate, None, <KeycardUACPCC 20120623102653-9 *hide*@127.0.0.1 for requesterId None in state REQUESTING>) (flumotion/common/medium.py:283)
DEBUG [ 2089] workermedium Jun 23 10:27:23 baseavatar <-- WORKERMEDIUM: callRemote(getKeycardClasses, ): ['flumotion.common.keycards.KeycardUACPCC', 'flumotion.common.keycards.KeycardUACPP'] (flumotion/common/medium.py:283)
DEBUG [ 2089] workermedium Jun 23 10:27:23 baseavatar <-- WORKERMEDIUM: callRemote(authenticate, None, <KeycardUACPCC 20120623102653-9 *hide*@127.0.0.1 for requesterId None in state REQUESTING>): <KeycardUACPCC 20120623102653-9 *hide*@127.0.0.1 for requesterId None in state AUTHENTICATED> (flumotion/common/medium.py:283)
DEBUG [ 2089] BouncerPortal Jun 23 10:27:23 authenticated login of <KeycardUACPCC 20120623102653-9 *hide*@127.0.0.1 for requesterId None in state AUTHENTICATED> into realm <flumotion.worker.feedserver.FeedServer instance at 0x16b4488> (flumotion/twisted/portal.py:129)
DEBUG [ 2089] "/default/muxer-video:default" feedavatar Jun 23 10:27:23 created new Avatar with id /default/muxer-video:default (flumotion/twisted/pb.py:618)
DEBUG [ 2089] "/default/muxer-video:default" feedavatar Jun 23 10:27:23 PB client connection seen by me is from me 127.0.0.1 to 127.0.0.1 (flumotion/twisted/pb.py:694)
DEBUG [ 2089] authenticator Jun 23 10:27:23 Issuing keycard <KeycardUACPCC None *hide*@localhost for requesterId None in state REQUESTING> of class KeycardUACPCC (flumotion/twisted/pb.py:455)
DEBUG [ 2107] feedclient Jun 23 10:27:23 login successful, returning <twisted.spread.pb.RemoteReference instance at 0x28666c8> (flumotion/twisted/pb.py:179)
DEBUG [ 2106] feedclient Jun 23 10:27:23 using keycard: <KeycardUACPCC None *hide*@localhost for requesterId None in state REQUESTING> (flumotion/twisted/pb.py:142)
DEBUG [ 2089] "/default/muxer-video:default" feedavatar Jun 23 10:27:23 feedmedium --> FEEDAVATAR: perspective_sendFeed('/default/encoder-video:default') (flumotion/worker/feedserver.py:114)
DEBUG [ 2089] "/default/muxer-video:default" feedavatar Jun 23 10:27:23 feedmedium --> FEEDAVATAR: callRemote(sendFeedReply, '/default/encoder-video:default') (flumotion/twisted/pb.py:751)
DEBUG [ 2089] "/default/muxer-video:default" feedavatar Jun 23 10:27:23 feedmedium <-- FEEDAVATAR: perspective_sendFeed('/default/encoder-video:default'): 'None' (flumotion/worker/feedserver.py:114)
DEBUG [ 2089] BouncerPortal Jun 23 10:27:23 _login(keycard=<KeycardUACPCC None *hide*@localhost for requesterId None in state REQUESTING>, mind=<twisted.spread.pb.RemoteReference instance at 0x18a9a28>, ifaces=(<InterfaceClass flumotion.common.interfaces.IFeedMedium>, <InterfaceClass twisted.spread.pb.IPerspective>)) (flumotion/twisted/portal.py:86)
DEBUG [ 2089] proxybouncer Jun 23 10:27:23 Authenticating keycard <KeycardUACPCC None *hide*@127.0.0.1 for requesterId None in state REQUESTING> against remote bouncer (flumotion/worker/worker.py:56)
DEBUG [ 2089] workermedium Jun 23 10:27:23 baseavatar --> WORKERMEDIUM: callRemote(authenticate, None, <KeycardUACPCC None *hide*@127.0.0.1 for requesterId None in state REQUESTING>) (flumotion/common/medium.py:283)
DEBUG [ 2107] "muxer-video" feedmedium Jun 23 10:27:23 feedserver --> FEEDMEDIUM: remote_sendFeedReply('/default/encoder-video:default') (flumotion/component/feed.py:281)
DEBUG [ 2107] "muxer-video" feedmedium Jun 23 10:27:23 stop reading from transport (flumotion/component/feed.py:284)
DEBUG [ 2107] "muxer-video" feedmedium Jun 23 10:27:23 feedserver <-- FEEDMEDIUM: remote_sendFeedReply('/default/encoder-video:default'): 'None' (flumotion/component/feed.py:281)
DEBUG [ 2107] "muxer-video" feedmedium Jun 23 10:27:23 flushing PB write queue (flumotion/component/feed.py:289)
DEBUG [ 2107] "muxer-video" feedmedium Jun 23 10:27:23 stop writing to transport (flumotion/component/feed.py:291)
WARN [ 2107] twisted Jun 23 10:27:23 A twisted traceback occurred. (twisted/internet/base.py:802)

Twisted traceback:
Traceback (most recent call last):
  File "/usr/lib/flumotion/python/flumotion/common/boot.py", line 305, in boot
    sys.exit(wrapped(sys.argv))
  File "/usr/lib/flumotion/python/flumotion/job/main.py", line 64, in main
    reactor.run()
  File "/usr/lib/python2.7/dist-packages/twisted/internet/_glibbase.py", line 282, in run
    self._run()
  File "/usr/lib/python2.7/dist-packages/twisted/internet/_glibbase.py", line 313, in _simulate
    self.runUntilCurrent()
--- <exception caught here> ---
  File "/usr/lib/python2.7/dist-packages/twisted/internet/base.py", line 800, in runUntilCurrent
    call.func(*call.args, **call.kw)
  File "/var/cache/flumotion/.flumotion/component/53ef3f5c83a640daf25fd00124a8e82d/flumotion/component/feed.py", line 301, in _doFeedTo
    t.connectionLost(failure.Failure(main.CONNECTION_DONE))
  File "/usr/lib/python2.7/dist-packages/twisted/internet/tcp.py", line 433, in connectionLost
    Connection.connectionLost(self, reason)
  File "/usr/lib/python2.7/dist-packages/twisted/internet/tcp.py", line 272, in connectionLost
    self._closeSocket(not reason.check(error.ConnectionAborted))
exceptions.TypeError: _closeSocket() takes exactly 1 argument (2 given)

DEBUG [ 2107] twisted Jun 23 10:27:23 [-] Traceback (most recent call last):
   File "/usr/lib/flumotion/python/flumotion/common/boot.py", line 305, in boot
     sys.exit(wrapped(sys.argv))
   File "/usr/lib/flumotion/python/flumotion/job/main.py", line 64, in main
     reactor.run()
   File "/usr/lib/python2.7/dist-packages/twisted/internet/_glibbase.py", line 282, in run
     self._run()
   File "/usr/lib/python2.7/dist-packages/twisted/internet/_glibbase.py", line 313, in _simulate
     self.runUntilCurrent()
 --- <exception caught here> ---
   File "/usr/lib/python2.7/dist-packages/twisted/internet/base.py", line 800, in runUntilCurrent
     call.func(*call.args, **call.kw)
   File "/var/cache/flumotion/.flumotion/component/53ef3f5c83a640daf25fd00124a8e82d/flumotion/component/feed.py", line 301, in _doFeedTo
     t.connectionLost(failure.Failure(main.CONNECTION_DONE))
   File "/usr/lib/python2.7/dist-packages/twisted/internet/tcp.py", line 433, in connectionLost
     Connection.connectionLost(self, reason)
   File "/usr/lib/python2.7/dist-packages/twisted/internet/tcp.py", line 272, in connectionLost
     self._closeSocket(not reason.check(error.ConnectionAborted))
 exceptions.TypeError: _closeSocket() takes exactly 1 argument (2 given)

 (twisted/internet/base.py:802)
DEBUG [ 2089] workermedium Jun 23 10:27:23 baseavatar <-- WORKERMEDIUM: callRemote(authenticate, None, <KeycardUACPCC None *hide*@127.0.0.1 for requesterId None in state REQUESTING>): <KeycardUACPCC 20120623102653-10 *hide*@127.0.0.1 for requesterId None in state REQUESTING> (flumotion/common/medium.py:283)
DEBUG [ 2089] "/default/muxer-video:default" feedavatar Jun 23 10:27:23 feedmedium <-- FEEDAVATAR: callRemote(sendFeedReply, '/default/encoder-video:default'): 'None' (flumotion/twisted/pb.py:751)
DEBUG [ 2089] "/default/muxer-video:default" feedavatar Jun 23 10:27:23 Attempting to send FD: 21 (flumotion/worker/feedserver.py:132)
DEBUG [ 2089] "/default/encoder-video" job-avatar Jun 23 10:27:23 Sending FD 21 to component job to feed default to fd (flumotion/worker/job.py:107)
DEBUG [ 2105] default Jun 23 10:27:23 received fds [14], message 'sendFeed default /default/muxer-video:default' (flumotion/job/job.py:331)
DEBUG [ 2105] "encoder-video" feedcomponent Jun 23 10:27:23 FeedToFD(default, 14) (flumotion/component/feedcomponent010.py:788)
WARN [ 2089] twisted Jun 23 10:27:23 A twisted traceback occurred. (twisted/internet/pollreactor.py:167)

Twisted traceback:
Traceback (most recent call last):
  File "/usr/lib/flumotion/python/flumotion/worker/main.py", line 269, in main
    reactor.run()
  File "/usr/lib/python2.7/dist-packages/twisted/internet/base.py", line 1169, in run
    self.mainLoop()
  File "/usr/lib/python2.7/dist-packages/twisted/internet/base.py", line 1181, in mainLoop
    self.doIteration(t)
  File "/usr/lib/python2.7/dist-packages/twisted/internet/pollreactor.py", line 167, in doPoll
    log.callWithLogger(selectable, _drdw, selectable, fd, event)
--- <exception caught here> ---
  File "/usr/lib/python2.7/dist-packages/twisted/python/log.py", line 84, in callWithLogger
    return callWithContext({"system": lp}, func, *args, **kw)
  File "/usr/lib/python2.7/dist-packages/twisted/python/log.py", line 69, in callWithContext
    return context.call({ILogContext: newCtx}, func, *args, **kw)
  File "/usr/lib/python2.7/dist-packages/twisted/python/context.py", line 118, in callWithContext
    return self.currentContext().callWithContext(ctx, func, *args, **kw)
  File "/usr/lib/python2.7/dist-packages/twisted/python/context.py", line 81, in callWithContext
    return func(*args,**kw)
  File "/usr/lib/python2.7/dist-packages/twisted/internet/posixbase.py", line 599, in _doReadOrWrite
    self._disconnectSelectable(selectable, why, inRead)
  File "/usr/lib/python2.7/dist-packages/twisted/internet/posixbase.py", line 263, in _disconnectSelectable
    selectable.connectionLost(f)
  File "/usr/lib/python2.7/dist-packages/twisted/internet/tcp.py", line 272, in connectionLost
    self._closeSocket(not reason.check(error.ConnectionAborted))
exceptions.TypeError: _closeSocket() takes exactly 1 argument (2 given)

DEBUG [ 2089] twisted Jun 23 10:27:23 [Broker,1,127.0.0.1] Traceback (most recent call last):
   File "/usr/lib/flumotion/python/flumotion/worker/main.py", line 269, in main
     reactor.run()
   File "/usr/lib/python2.7/dist-packages/twisted/internet/base.py", line 1169, in run
     self.mainLoop()
   File "/usr/lib/python2.7/dist-packages/twisted/internet/base.py", line 1181, in mainLoop
     self.doIteration(t)
   File "/usr/lib/python2.7/dist-packages/twisted/internet/pollreactor.py", line 167, in doPoll
     log.callWithLogger(selectable, _drdw, selectable, fd, event)
 --- <exception caught here> ---
   File "/usr/lib/python2.7/dist-packages/twisted/python/log.py", line 84, in callWithLogger
     return callWithContext({"system": lp}, func, *args, **kw)
   File "/usr/lib/python2.7/dist-packages/twisted/python/log.py", line 69, in callWithContext
     return context.call({ILogContext: newCtx}, func, *args, **kw)
   File "/usr/lib/python2.7/dist-packages/twisted/python/context.py", line 118, in callWithContext
     return self.currentContext().callWithContext(ctx, func, *args, **kw)
   File "/usr/lib/python2.7/dist-packages/twisted/python/context.py", line 81, in callWithContext
     return func(*args,**kw)
   File "/usr/lib/python2.7/dist-packages/twisted/internet/posixbase.py", line 599, in _doReadOrWrite
     self._disconnectSelectable(selectable, why, inRead)
   File "/usr/lib/python2.7/dist-packages/twisted/internet/posixbase.py", line 263, in _disconnectSelectable
     selectable.connectionLost(f)
   File "/usr/lib/python2.7/dist-packages/twisted/internet/tcp.py", line 272, in connectionLost
     self._closeSocket(not reason.check(error.ConnectionAborted))
 exceptions.TypeError: _closeSocket() takes exactly 1 argument (2 given)

 (twisted/internet/pollreactor.py:167)
DEBUG [ 2089] authenticator Jun 23 10:27:23 responding to challenge on keycard <KeycardUACPCC 20120623102653-10 *hide*@127.0.0.1 for requesterId None in state REQUESTING> (flumotion/twisted/pb.py:495)
DEBUG [ 2089] BouncerPortal Jun 23 10:27:23 _login(keycard=<KeycardUACPCC 20120623102653-10 *hide*@127.0.0.1 for requesterId None in state REQUESTING>, mind=<twisted.spread.pb.RemoteReference instance at 0x18a9cb0>, ifaces=(<InterfaceClass flumotion.common.interfaces.IFeedMedium>, <InterfaceClass twisted.spread.pb.IPerspective>)) (flumotion/twisted/portal.py:86)
DEBUG [ 2089] proxybouncer Jun 23 10:27:23 Authenticating keycard <KeycardUACPCC 20120623102653-10 *hide*@127.0.0.1 for requesterId None in state REQUESTING> against remote bouncer (flumotion/worker/worker.py:56)
DEBUG [ 2089] workermedium Jun 23 10:27:23 baseavatar --> WORKERMEDIUM: callRemote(authenticate, None, <KeycardUACPCC 20120623102653-10 *hide*@127.0.0.1 for requesterId None in state REQUESTING>) (flumotion/common/medium.py:283)
DEBUG [ 2089] workermedium Jun 23 10:27:23 baseavatar <-- WORKERMEDIUM: callRemote(authenticate, None, <KeycardUACPCC 20120623102653-10 *hide*@127.0.0.1 for requesterId None in state REQUESTING>): <KeycardUACPCC 20120623102653-10 *hide*@127.0.0.1 for requesterId None in state AUTHENTICATED> (flumotion/common/medium.py:283)
DEBUG [ 2089] BouncerPortal Jun 23 10:27:23 authenticated login of <KeycardUACPCC 20120623102653-10 *hide*@127.0.0.1 for requesterId None in state AUTHENTICATED> into realm <flumotion.worker.feedserver.FeedServer instance at 0x16b4488> (flumotion/twisted/portal.py:129)
DEBUG [ 2089] "/default/http-video:default" feedavatar Jun 23 10:27:23 created new Avatar with id /default/http-video:default (flumotion/twisted/pb.py:618)
DEBUG [ 2089] "/default/http-video:default" feedavatar Jun 23 10:27:23 PB client connection seen by me is from me 127.0.0.1 to 127.0.0.1 (flumotion/twisted/pb.py:694)
DEBUG [ 2106] feedclient Jun 23 10:27:23 login successful, returning <twisted.spread.pb.RemoteReference instance at 0x29a2e18> (flumotion/twisted/pb.py:179)
DEBUG [ 2089] "/default/http-video:default" feedavatar Jun 23 10:27:23 feedmedium --> FEEDAVATAR: perspective_sendFeed('/default/muxer-video:default') (flumotion/worker/feedserver.py:114)
DEBUG [ 2089] "/default/http-video:default" feedavatar Jun 23 10:27:23 feedmedium --> FEEDAVATAR: callRemote(sendFeedReply, '/default/muxer-video:default') (flumotion/twisted/pb.py:751)
DEBUG [ 2089] "/default/http-video:default" feedavatar Jun 23 10:27:23 feedmedium <-- FEEDAVATAR: perspective_sendFeed('/default/muxer-video:default'): 'None' (flumotion/worker/feedserver.py:114)
DEBUG [ 2106] "http-video" feedmedium Jun 23 10:27:23 feedserver --> FEEDMEDIUM: remote_sendFeedReply('/default/muxer-video:default') (flumotion/component/feed.py:281)
DEBUG [ 2106] "http-video" feedmedium Jun 23 10:27:23 stop reading from transport (flumotion/component/feed.py:284)
DEBUG [ 2106] "http-video" feedmedium Jun 23 10:27:23 feedserver <-- FEEDMEDIUM: remote_sendFeedReply('/default/muxer-video:default'): 'None' (flumotion/component/feed.py:281)
DEBUG [ 2106] "http-video" feedmedium Jun 23 10:27:23 flushing PB write queue (flumotion/component/feed.py:289)
DEBUG [ 2106] "http-video" feedmedium Jun 23 10:27:23 stop writing to transport (flumotion/component/feed.py:291)
WARN [ 2106] twisted Jun 23 10:27:23 A twisted traceback occurred. (twisted/internet/base.py:802)

Twisted traceback:
Traceback (most recent call last):
  File "/usr/lib/flumotion/python/flumotion/common/boot.py", line 305, in boot
    sys.exit(wrapped(sys.argv))
  File "/usr/lib/flumotion/python/flumotion/job/main.py", line 64, in main
    reactor.run()
  File "/usr/lib/python2.7/dist-packages/twisted/internet/_glibbase.py", line 282, in run
    self._run()
  File "/usr/lib/python2.7/dist-packages/twisted/internet/_glibbase.py", line 313, in _simulate
    self.runUntilCurrent()
--- <exception caught here> ---
  File "/usr/lib/python2.7/dist-packages/twisted/internet/base.py", line 800, in runUntilCurrent
    call.func(*call.args, **call.kw)
  File "/var/cache/flumotion/.flumotion/component/53ef3f5c83a640daf25fd00124a8e82d/flumotion/component/feed.py", line 301, in _doFeedTo
    t.connectionLost(failure.Failure(main.CONNECTION_DONE))
  File "/usr/lib/python2.7/dist-packages/twisted/internet/tcp.py", line 433, in connectionLost
    Connection.connectionLost(self, reason)
  File "/usr/lib/python2.7/dist-packages/twisted/internet/tcp.py", line 272, in connectionLost
    self._closeSocket(not reason.check(error.ConnectionAborted))
exceptions.TypeError: _closeSocket() takes exactly 1 argument (2 given)

DEBUG [ 2106] twisted Jun 23 10:27:23 [-] Traceback (most recent call last):
   File "/usr/lib/flumotion/python/flumotion/common/boot.py", line 305, in boot
     sys.exit(wrapped(sys.argv))
   File "/usr/lib/flumotion/python/flumotion/job/main.py", line 64, in main
     reactor.run()
   File "/usr/lib/python2.7/dist-packages/twisted/internet/_glibbase.py", line 282, in run
     self._run()
   File "/usr/lib/python2.7/dist-packages/twisted/internet/_glibbase.py", line 313, in _simulate
     self.runUntilCurrent()
 --- <exception caught here> ---
   File "/usr/lib/python2.7/dist-packages/twisted/internet/base.py", line 800, in runUntilCurrent
     call.func(*call.args, **call.kw)
   File "/var/cache/flumotion/.flumotion/component/53ef3f5c83a640daf25fd00124a8e82d/flumotion/component/feed.py", line 301, in _doFeedTo
     t.connectionLost(failure.Failure(main.CONNECTION_DONE))
   File "/usr/lib/python2.7/dist-packages/twisted/internet/tcp.py", line 433, in connectionLost
     Connection.connectionLost(self, reason)
   File "/usr/lib/python2.7/dist-packages/twisted/internet/tcp.py", line 272, in connectionLost
     self._closeSocket(not reason.check(error.ConnectionAborted))
 exceptions.TypeError: _closeSocket() takes exactly 1 argument (2 given)

 (twisted/internet/base.py:802)
DEBUG [ 2089] "/default/http-video:default" feedavatar Jun 23 10:27:23 feedmedium <-- FEEDAVATAR: callRemote(sendFeedReply, '/default/muxer-video:default'): 'None' (flumotion/twisted/pb.py:751)
DEBUG [ 2089] "/default/http-video:default" feedavatar Jun 23 10:27:23 Attempting to send FD: 22 (flumotion/worker/feedserver.py:132)
DEBUG [ 2089] "/default/muxer-video" job-avatar Jun 23 10:27:23 Sending FD 22 to component job to feed default to fd (flumotion/worker/job.py:107)
DEBUG [ 2107] default Jun 23 10:27:23 received fds [14], message 'sendFeed default /default/http-video:default' (flumotion/job/job.py:331)
DEBUG [ 2107] "muxer-video" feedcomponent Jun 23 10:27:23 FeedToFD(default, 14) (flumotion/component/feedcomponent010.py:788)
WARN [ 2089] twisted Jun 23 10:27:23 A twisted traceback occurred. (twisted/internet/pollreactor.py:167)

Twisted traceback:
Traceback (most recent call last):
  File "/usr/lib/flumotion/python/flumotion/worker/main.py", line 269, in main
    reactor.run()
  File "/usr/lib/python2.7/dist-packages/twisted/internet/base.py", line 1169, in run
    self.mainLoop()
  File "/usr/lib/python2.7/dist-packages/twisted/internet/base.py", line 1181, in mainLoop
    self.doIteration(t)
  File "/usr/lib/python2.7/dist-packages/twisted/internet/pollreactor.py", line 167, in doPoll
    log.callWithLogger(selectable, _drdw, selectable, fd, event)
--- <exception caught here> ---
  File "/usr/lib/python2.7/dist-packages/twisted/python/log.py", line 84, in callWithLogger
    return callWithContext({"system": lp}, func, *args, **kw)
  File "/usr/lib/python2.7/dist-packages/twisted/python/log.py", line 69, in callWithContext
    return context.call({ILogContext: newCtx}, func, *args, **kw)
  File "/usr/lib/python2.7/dist-packages/twisted/python/context.py", line 118, in callWithContext
    return self.currentContext().callWithContext(ctx, func, *args, **kw)
  File "/usr/lib/python2.7/dist-packages/twisted/python/context.py", line 81, in callWithContext
    return func(*args,**kw)
  File "/usr/lib/python2.7/dist-packages/twisted/internet/posixbase.py", line 599, in _doReadOrWrite
    self._disconnectSelectable(selectable, why, inRead)
  File "/usr/lib/python2.7/dist-packages/twisted/internet/posixbase.py", line 263, in _disconnectSelectable
    selectable.connectionLost(f)
  File "/usr/lib/python2.7/dist-packages/twisted/internet/tcp.py", line 272, in connectionLost
    self._closeSocket(not reason.check(error.ConnectionAborted))
exceptions.TypeError: _closeSocket() takes exactly 1 argument (2 given)

DEBUG [ 2089] twisted Jun 23 10:27:23 [Broker,2,127.0.0.1] Traceback (most recent call last):
   File "/usr/lib/flumotion/python/flumotion/worker/main.py", line 269, in main
     reactor.run()
   File "/usr/lib/python2.7/dist-packages/twisted/internet/base.py", line 1169, in run
     self.mainLoop()
   File "/usr/lib/python2.7/dist-packages/twisted/internet/base.py", line 1181, in mainLoop
     self.doIteration(t)
   File "/usr/lib/python2.7/dist-packages/twisted/internet/pollreactor.py", line 167, in doPoll
     log.callWithLogger(selectable, _drdw, selectable, fd, event)
 --- <exception caught here> ---
   File "/usr/lib/python2.7/dist-packages/twisted/python/log.py", line 84, in callWithLogger
     return callWithContext({"system": lp}, func, *args, **kw)
   File "/usr/lib/python2.7/dist-packages/twisted/python/log.py", line 69, in callWithContext
     return context.call({ILogContext: newCtx}, func, *args, **kw)
   File "/usr/lib/python2.7/dist-packages/twisted/python/context.py", line 118, in callWithContext
     return self.currentContext().callWithContext(ctx, func, *args, **kw)
   File "/usr/lib/python2.7/dist-packages/twisted/python/context.py", line 81, in callWithContext
     return func(*args,**kw)
   File "/usr/lib/python2.7/dist-packages/twisted/internet/posixbase.py", line 599, in _doReadOrWrite
     self._disconnectSelectable(selectable, why, inRead)
   File "/usr/lib/python2.7/dist-packages/twisted/internet/posixbase.py", line 263, in _disconnectSelectable
     selectable.connectionLost(f)
   File "/usr/lib/python2.7/dist-packages/twisted/internet/tcp.py", line 272, in connectionLost
     self._closeSocket(not reason.check(error.ConnectionAborted))
 exceptions.TypeError: _closeSocket() takes exactly 1 argument (2 given)

 (twisted/internet/pollreactor.py:167)
DEBUG [ 2106] "http-video" feedcompmed Jun 23 10:27:24 feedserver --> FEEDCOMPMED: remote_getUIState() (flumotion/component/component.py:262)
DEBUG [ 2106] "http-video" feedcompmed Jun 23 10:27:24 feedserver <-- FEEDCOMPMED: remote_getUIState(): '<flumotion.common.componentui.WorkerComponentUIState instance at 0x2786fc8>' (flumotion/component/component.py:262)
DEBUG [ 2106] "http-video" cons-http Jun 23 10:27:24 observer has started watching us, starting pollers (flumotion/component/component.py:407)

Revision history for this message
Robbert Muller (mjrider) wrote :

Just tested the suggested fix in the bugreport with debian. It works

Changed in flumotion (Debian):
status: Unknown → Fix Released
Changed in flumotion:
status: Unknown → New
Changed in flumotion:
status: New → Fix Released
To post a comment you must log in.
This report contains Public information  
Everyone can see this information.

Other bug subscribers

Remote bug watches

Bug watches keep track of this bug in other bug trackers.