ant-media / Ant-Media-Server

Ant Media Server is a live streaming engine software that provides adaptive, ultra low latency streaming by using WebRTC technology with ~0.5 seconds latency. Ant Media Server is auto-scalable and it can run on-premise or on-cloud.
https://antmedia.io
Other
4.31k stars 636 forks source link

AWS GPU Instance NoClassDefFoundError error #3400

Open SelimEmre opened 3 years ago

SelimEmre commented 3 years ago

Short description

One of our clients reported this issue.

Steps to reproduce

  1. Open GPU Instance(g2.2xlarge) on AWS Marketplace AMI
  2. Add broadcast object, add 2 adaptive options
  3. Send RTMP stream to broadcast object

Expected behavior

It should send/play stream properly

Actual behavior

It's not working properly

Logs

021-06-29 12:26:14,865 [main] INFO  org.red5.server.Launcher - Ant Media Server Enterprise 2.3.3.1
2021-06-29 12:26:14,868 [main] INFO  org.red5.server.Launcher - 
                                                             
             `..-:/++oosssyyyyyyyysssoo++/::..`             
        .:+osyyyyysooo++///::::::///++ooosyyyyyso+:.        
     -+syyso/:-.`         ```````          `.-:/osyyy+-     
   .oyyo:.    ``.-:/+oossyyyyyys:`.+o+: `..`      `-+yys.   
   oyy-   `.-:://:::::///++ooo-`-oyo:../sys/`.::.    .yys   
   syy+`                       `.-. -oys/..:oys+:`   :yyy   
   syyyo-`                           `. `+so/.`   `-oyyyy   
   syy+sys+:.`                           ``   `.:+syyoyyy   
   syy``:+syyso`       `..`                 `osyyso:. syy   
   syy`   `.oyy.      :syyso:.`             `yys.`    syy   
   syy`     +yy.      syy:+syys+-`          `yyo      syy   
   syy`     +yy.      yyy  `.:osyso/.`      `yyo      syy   
   syy`     +yy.      yyy      `-/syys+.    `yyo      syy   
   syy`     +yy.      yyy         `./yyy    `yyo      syy   
   syy`     +yy.      yyy       `./oyys/    `yyo      syy   
   syy`     +yy.      yyy    .:+syyo/-`     `yyo      syy   
   syy`     +yy.      yyy`-/syys+:.         `yyo      syy   
   syy`     +yy.      +yyyyyo/.`            `yyo      yyy   
   /yy/     +yy.       -::-`                `yyo     :yy+   
    +yyo:.  +yy.                            `yyo  .-oyy+`   
     .+yyyysyyy.                            `yyysyyyy+-     
        .:/+++/                              :+//:-.        



2021-06-29 12:26:15,333 [main] INFO  o.s.c.s.FileSystemXmlApplicationContext - Refreshing org.springframework.context.support.FileSystemXmlApplicationContext@64c63c79: startup date [Tue Jun 29 12:26:15 UTC 2021]; root of context hierarchy
2021-06-29 12:26:15,377 [main] INFO  o.s.b.f.xml.XmlBeanDefinitionReader - Loading XML bean definitions from class path resource [red5.xml]
2021-06-29 12:26:16,208 [main] INFO  o.s.b.f.xml.XmlBeanDefinitionReader - Loading XML bean definitions from class path resource [jee-container.xml]
2021-06-29 12:26:17,251 [main] INFO  o.s.b.f.a.AutowiredAnnotationBeanPostProcessor - JSR-330 'javax.inject.Inject' annotation found and supported for autowiring
2021-06-29 12:26:17,318 [main] INFO  o.r.spring.Red5ApplicationContext - setApplicationContext: org.springframework.context.support.FileSystemXmlApplicationContext@64c63c79: startup date [Tue Jun 29 12:26:15 UTC 2021]; root of context hierarchy
2021-06-29 12:26:17,318 [main] INFO  o.r.spring.Red5ApplicationContext - Red5ApplicationContext init
2021-06-29 12:26:17,320 [main] INFO  o.r.spring.Red5ApplicationContext - Refreshing ApplicationContext 'red5.common': startup date [Tue Jun 29 12:26:17 UTC 2021]; parent: org.springframework.context.support.FileSystemXmlApplicationContext@64c63c79
2021-06-29 12:26:17,320 [main] INFO  o.s.b.f.xml.XmlBeanDefinitionReader - Loading XML bean definitions from class path resource [red5-common.xml]
2021-06-29 12:26:17,515 [main] INFO  o.s.b.f.a.AutowiredAnnotationBeanPostProcessor - JSR-330 'javax.inject.Inject' annotation found and supported for autowiring
2021-06-29 12:26:17,661 [main] INFO  org.quartz.impl.StdSchedulerFactory - Using default implementation for ThreadExecutor
2021-06-29 12:26:17,679 [main] INFO  o.quartz.core.SchedulerSignalerImpl - Initialized Scheduler Signaller of type: class org.quartz.core.SchedulerSignalerImpl
2021-06-29 12:26:17,680 [main] INFO  org.quartz.core.QuartzScheduler - Quartz Scheduler v.2.2.3 created.
2021-06-29 12:26:17,681 [main] INFO  org.quartz.simpl.RAMJobStore - RAMJobStore initialized.
2021-06-29 12:26:17,682 [main] INFO  org.quartz.core.QuartzScheduler - Scheduler meta-data: Quartz Scheduler (v2.2.3) 'Red5_Scheduler' with instanceId 'NON_CLUSTERED'
  Scheduler class: 'org.quartz.core.QuartzScheduler' - running locally.
  NOT STARTED.
  Currently in standby mode.
  Number of jobs executed: 0
  Using thread pool 'org.quartz.simpl.SimpleThreadPool' - with 6 threads.
  Using job-store 'org.quartz.simpl.RAMJobStore' - which does not support persistence. and is not clustered.

2021-06-29 12:26:17,682 [main] INFO  org.quartz.impl.StdSchedulerFactory - Quartz scheduler 'Red5_Scheduler' initialized from the specified file : '/usr/local/antmedia/conf/quartz.properties'
2021-06-29 12:26:17,683 [main] INFO  org.quartz.impl.StdSchedulerFactory - Quartz scheduler version: 2.2.3
2021-06-29 12:26:17,683 [main] INFO  org.quartz.core.QuartzScheduler - Scheduler Red5_Scheduler_$_NON_CLUSTERED started.
2021-06-29 12:26:18,738 [main] INFO  o.s.s.c.ThreadPoolTaskScheduler - Initializing ExecutorService 'org.springframework.scheduling.concurrent.ThreadPoolTaskScheduler#3c8bdd5b'
2021-06-29 12:26:20,357 [main] WARN  i.antmedia.statistic.StatsCollector - Starting heartbeats for the version:2.3.3.1 and type:Enterprise
2021-06-29 12:26:20,413 [main] INFO  o.s.j.e.a.AnnotationMBeanExporter - Registering beans for JMX exposure on startup
2021-06-29 12:26:20,501 [main] INFO  o.s.j.e.a.AnnotationMBeanExporter - Bean with name 'schedulingService' has been autodetected for JMX exposure
2021-06-29 12:26:20,501 [main] INFO  o.s.j.e.a.AnnotationMBeanExporter - Bean with name 'clientBroadcastStream' has been autodetected for JMX exposure
2021-06-29 12:26:20,783 [main] INFO  o.s.j.e.a.AnnotationMBeanExporter - Located MBean 'schedulingService': registering with JMX server as MBean [org.red5.server:name=schedulingService,type=QuartzSchedulingService]
2021-06-29 12:26:21,008 [main] INFO  o.r.spring.Red5ApplicationContext - setApplicationContext: org.springframework.context.support.FileSystemXmlApplicationContext@64c63c79: startup date [Tue Jun 29 12:26:15 UTC 2021]; root of context hierarchy
2021-06-29 12:26:21,008 [main] INFO  o.r.spring.Red5ApplicationContext - Red5ApplicationContext init
2021-06-29 12:26:21,008 [main] INFO  o.r.spring.Red5ApplicationContext - Refreshing ApplicationContext 'red5.core': startup date [Tue Jun 29 12:26:21 UTC 2021]; parent: ApplicationContext 'red5.common'
2021-06-29 12:26:21,009 [main] INFO  o.s.b.f.xml.XmlBeanDefinitionReader - Loading XML bean definitions from class path resource [red5-core.xml]
2021-06-29 12:26:21,371 [main] INFO  o.s.s.c.ThreadPoolTaskScheduler - Initializing ExecutorService 'rtmpScheduler'
2021-06-29 12:26:21,379 [main] INFO  o.s.s.c.ThreadPoolTaskExecutor - Initializing ExecutorService 'messageExecutor'
2021-06-29 12:26:21,380 [main] INFO  o.s.s.c.ThreadPoolTaskScheduler - Initializing ExecutorService 'deadlockGuardScheduler'
2021-06-29 12:26:21,415 [main] INFO  o.r.s.net.rtmp.RTMPMinaTransport - RTMP will be bound to [0.0.0.0:1935]
2021-06-29 12:26:21,416 [main] INFO  o.r.s.net.rtmp.RTMPMinaTransport - RTMP Mina Transport Settings
Acceptor style: default I/O threads: 16
TCP no-delay: true keep-alive: false
2021-06-29 12:26:21,537 [main] INFO  o.r.s.net.rtmp.RTMPMinaTransport - Traffic class modification is disabled
2021-06-29 12:26:21,537 [main] INFO  o.r.s.net.rtmp.RTMPMinaTransport - Send buffer size: 65536 recv buffer size: 65536 so linger: -1 traffic class: 0
2021-06-29 12:26:21,569 [main] INFO  org.red5.server.ContextLoader - ContextLoader init
2021-06-29 12:26:21,577 [main] INFO  org.red5.server.ContextLoader - Loading: default.context = ${red5.root}/webapps/red5-default.xml => /usr/local/antmedia/webapps/red5-default.xml
2021-06-29 12:26:21,579 [main] INFO  o.s.c.s.FileSystemXmlApplicationContext - Refreshing org.springframework.context.support.FileSystemXmlApplicationContext@5ebffb44: startup date [Tue Jun 29 12:26:21 UTC 2021]; parent: ApplicationContext 'red5.common'
2021-06-29 12:26:21,579 [main] INFO  o.s.b.f.xml.XmlBeanDefinitionReader - Loading XML bean definitions from URL [file:/usr/local/antmedia/webapps/red5-default.xml]
2021-06-29 12:26:21,748 [main] INFO  org.red5.server.Context - Setting parent bean factory as core
2021-06-29 12:26:22,648 [main] INFO  org.red5.server.tomcat.WarDeployer - War deployer service created
2021-06-29 12:26:22,652 [main] INFO  org.red5.server.tomcat.WarDeployer - Starting WarDeployer
2021-06-29 12:26:22,653 [main] INFO  org.red5.server.tomcat.WarDeployer - Deploy wars without app start
2021-06-29 12:26:23,300 [main] INFO  org.red5.server.tomcat.TomcatLoader - Loading Tomcat
2021-06-29 12:26:23,300 [main] INFO  org.red5.server.tomcat.TomcatLoader - Server root: /usr/local/antmedia
2021-06-29 12:26:23,300 [main] INFO  org.red5.server.tomcat.TomcatLoader - Config root: /usr/local/antmedia/conf
2021-06-29 12:26:23,324 [main] INFO  org.red5.server.tomcat.TomcatLoader - Application root: /usr/local/antmedia/webapps
2021-06-29 12:26:23,669 [main] INFO  org.red5.server.tomcat.TomcatLoader - Starting Tomcat servlet engine
2021-06-29 12:26:24,138 [main] INFO  o.a.c.core.AprLifecycleListener - Loaded Apache Tomcat Native library [1.2.25] using APR version [1.6.3].
2021-06-29 12:26:24,138 [main] INFO  o.a.c.core.AprLifecycleListener - APR capabilities: IPv6 [true], sendfile [true], accept filters [false], random [true].
2021-06-29 12:26:24,139 [main] INFO  o.a.c.core.AprLifecycleListener - APR/OpenSSL configuration: useAprConnector [false], useOpenSSL [true]
2021-06-29 12:26:24,145 [main] INFO  o.a.c.http11.Http11Nio2Protocol - Initializing ProtocolHandler ["http-nio2-0.0.0.0-5080"]
2021-06-29 12:26:24,204 [main] INFO  o.a.catalina.core.StandardService - Starting service [Tomcat]
2021-06-29 12:26:24,205 [main] INFO  o.a.catalina.core.StandardEngine - Starting Servlet Engine: Apache Tomcat/8.5.58
2021-06-29 12:26:24,270 [0.0.0.0-startStop-1] INFO  o.a.catalina.loader.WebappLoader - Unknown loader jdk.internal.loader.ClassLoaders$AppClassLoader@2c13da15 class jdk.internal.loader.ClassLoaders$AppClassLoader
2021-06-29 12:26:24,299 [0.0.0.0-startStop-1] INFO  o.a.catalina.startup.ContextConfig - No global web.xml found
2021-06-29 12:26:24,818 [0.0.0.0-startStop-1] INFO  o.a.c.c.C.[.[0.0.0.0].[/] - No Spring WebApplicationInitializer types detected on classpath
2021-06-29 12:26:24,858 [0.0.0.0-startStop-1] INFO  ROOT - Starting up context: root
2021-06-29 12:26:25,778 [0.0.0.0-startStop-1] ERROR o.g.j.s.s.SpringComponentProvider - Spring context lookup failed, skipping spring component provider initialization.
2021-06-29 12:26:26,658 [0.0.0.0-startStop-1] INFO  o.a.catalina.loader.WebappLoader - Unknown loader jdk.internal.loader.ClassLoaders$AppClassLoader@2c13da15 class jdk.internal.loader.ClassLoaders$AppClassLoader
2021-06-29 12:26:26,923 [0.0.0.0-startStop-1] INFO  o.a.c.c.C.[.[0.0.0.0].[/LiveApp] - No Spring WebApplicationInitializer types detected on classpath
2021-06-29 12:26:26,939 [0.0.0.0-startStop-1] INFO  ROOT - Starting up context: LiveApp
2021-06-29 12:26:27,110 [0.0.0.0-startStop-1] ERROR o.g.j.s.s.SpringComponentProvider - Spring context lookup failed, skipping spring component provider initialization.
2021-06-29 12:26:27,296 [0.0.0.0-startStop-1] INFO  o.a.catalina.loader.WebappLoader - Unknown loader jdk.internal.loader.ClassLoaders$AppClassLoader@2c13da15 class jdk.internal.loader.ClassLoaders$AppClassLoader
2021-06-29 12:26:27,360 [0.0.0.0-startStop-1] INFO  o.a.c.c.C.[.[.0.0.0].[/WebRTCAppEE] - No Spring WebApplicationInitializer types detected on classpath
2021-06-29 12:26:27,364 [0.0.0.0-startStop-1] INFO  ROOT - Starting up context: WebRTCAppEE
2021-06-29 12:26:27,479 [0.0.0.0-startStop-1] ERROR o.g.j.s.s.SpringComponentProvider - Spring context lookup failed, skipping spring component provider initialization.
2021-06-29 12:26:27,602 [main] INFO  o.a.c.http11.Http11Nio2Protocol - Starting ProtocolHandler ["http-nio2-0.0.0.0-5080"]
2021-06-29 12:26:27,605 [main] INFO  org.red5.server.tomcat.TomcatLoader - Context initialized:  path: /usr/local/antmedia/webapps/root/
2021-06-29 12:26:27,606 [main] INFO  org.red5.server.tomcat.TomcatLoader - Context initialized: /LiveApp path: /usr/local/antmedia/webapps/LiveApp/
2021-06-29 12:26:27,606 [main] INFO  org.red5.server.tomcat.TomcatLoader - Context initialized: /WebRTCAppEE path: /usr/local/antmedia/webapps/WebRTCAppEE/
2021-06-29 12:26:27,606 [main] INFO  org.red5.server.tomcat.TomcatLoader - Dedicated RTMPT server configuration was not specified
2021-06-29 12:26:27,608 [main] INFO  o.r.server.service.ShutdownServer - JEE server was found: TomcatLoader [serviceEngineName=red5Engine]
2021-06-29 12:26:27,629 [Loader:] INFO  o.s.w.c.s.XmlWebApplicationContext - Refreshing Root WebApplicationContext: startup date [Tue Jun 29 12:26:27 UTC 2021]; parent: org.springframework.context.support.FileSystemXmlApplicationContext@5ebffb44
2021-06-29 12:26:27,636 [main] INFO  i.a.e.licence.LicenceService - this is market build instance id: faacc9f8-d868-48fd-84e1-101b0dcf31bc
2021-06-29 12:26:27,641 [Loader:] INFO  o.s.b.f.xml.XmlBeanDefinitionReader - Loading XML bean definitions from ServletContext resource [/WEB-INF/red5-web.xml]
2021-06-29 12:26:27,709 [http-nio2-0.0.0.0-5080-exec-4] WARN  io.antmedia.filter.AbstractFilter - App context not running yet.
2021-06-29 12:26:27,709 [http-nio2-0.0.0.0-5080-exec-5] WARN  io.antmedia.filter.AbstractFilter - App context not running yet.
2021-06-29 12:26:27,859 [Loader:] INFO  o.s.b.f.a.AutowiredAnnotationBeanPostProcessor - JSR-330 'javax.inject.Inject' annotation found and supported for autowiring
2021-06-29 12:26:27,883 [Loader:] INFO  org.red5.server.Context - Setting parent bean factory as core
2021-06-29 12:26:27,949 [Loader:] INFO  org.red5.server.scope.WebScope - Set server [Server@1f66884cmap[[empty]]]
2021-06-29 12:26:27,958 [Loader:] INFO  org.red5.server.Server - Add mapping global: default host:  context: root
2021-06-29 12:26:27,960 [Loader:] INFO  org.red5.server.scope.WebScope - Webscope already registered; remove the 'init-method' from your 'web.scope' bean to prevent this message in the future.
2021-06-29 12:26:28,001 [Loader:/LiveApp] INFO  o.s.w.c.s.XmlWebApplicationContext - Refreshing Root WebApplicationContext: startup date [Tue Jun 29 12:26:28 UTC 2021]; parent: org.springframework.context.support.FileSystemXmlApplicationContext@5ebffb44
2021-06-29 12:26:28,002 [Loader:/LiveApp] INFO  o.s.b.f.xml.XmlBeanDefinitionReader - Loading XML bean definitions from ServletContext resource [/WEB-INF/red5-web.xml]
2021-06-29 12:26:28,339 [Loader:/LiveApp] INFO  o.s.b.f.a.AutowiredAnnotationBeanPostProcessor - JSR-330 'javax.inject.Inject' annotation found and supported for autowiring
2021-06-29 12:26:28,570 [Loader:/LiveApp] INFO  org.red5.server.Context - Setting parent bean factory as core
2021-06-29 12:26:31,489 [Loader:/LiveApp] INFO  i.a.datastore.db.DataStoreFactory - Used Datastore:mapdb  db name:liveapp
2021-06-29 12:26:31,512 [Loader:/LiveApp] INFO  org.red5.server.scope.WebScope - Set server [Server@1f66884cmap['/root' -> 'default']]
2021-06-29 12:26:31,513 [Loader:/LiveApp] INFO  org.red5.server.Server - Add mapping global: default host:  context: LiveApp
2021-06-29 12:26:31,535 [Loader:/LiveApp] INFO  i.a.AntMediaApplicationAdapter - Delete the ".closed" file in LiveApp
2021-06-29 12:26:31,544 [Loader:/LiveApp] INFO  i.a.enterprise.webrtc.WebRTCAdaptor - setting excessive bandwidth algorithm enabled:false 
2021-06-29 12:26:31,545 [Loader:/LiveApp] INFO  i.a.AntMediaApplicationAdapter - LiveApp started
2021-06-29 12:26:31,566 [vert.x-eventloop-thread-2] INFO  i.a.AntMediaApplicationAdapter - Stream source size: 0
2021-06-29 12:26:31,568 [vert.x-eventloop-thread-2] INFO  i.a.s.StreamFetcherManager - StreamFetcherSchedule job name 4
2021-06-29 12:26:31,568 [vert.x-eventloop-thread-2] INFO  i.a.AntMediaApplicationAdapter - socialEndpoints size: 0
2021-06-29 12:26:31,610 [Loader:/WebRTCAppEE] INFO  o.s.w.c.s.XmlWebApplicationContext - Refreshing Root WebApplicationContext: startup date [Tue Jun 29 12:26:31 UTC 2021]; parent: org.springframework.context.support.FileSystemXmlApplicationContext@5ebffb44
2021-06-29 12:26:31,611 [Loader:/WebRTCAppEE] INFO  o.s.b.f.xml.XmlBeanDefinitionReader - Loading XML bean definitions from ServletContext resource [/WEB-INF/red5-web.xml]
2021-06-29 12:26:31,791 [Loader:/WebRTCAppEE] INFO  o.s.b.f.a.AutowiredAnnotationBeanPostProcessor - JSR-330 'javax.inject.Inject' annotation found and supported for autowiring
2021-06-29 12:26:31,858 [Loader:/WebRTCAppEE] INFO  org.red5.server.Context - Setting parent bean factory as core
2021-06-29 12:26:32,006 [Loader:/WebRTCAppEE] INFO  i.a.datastore.db.DataStoreFactory - Used Datastore:mapdb  db name:webrtcappee
2021-06-29 12:26:32,012 [Loader:/WebRTCAppEE] INFO  org.red5.server.scope.WebScope - Set server [Server@1f66884cmap['/root' -> 'default', '/LiveApp' -> 'default']]
2021-06-29 12:26:32,013 [Loader:/WebRTCAppEE] INFO  org.red5.server.Server - Add mapping global: default host:  context: WebRTCAppEE
2021-06-29 12:26:32,015 [Loader:/WebRTCAppEE] INFO  i.a.AntMediaApplicationAdapter - Delete the ".closed" file in WebRTCAppEE
2021-06-29 12:26:32,018 [Loader:/WebRTCAppEE] INFO  i.a.enterprise.webrtc.WebRTCAdaptor - setting excessive bandwidth algorithm enabled:false 
2021-06-29 12:26:32,018 [Loader:/WebRTCAppEE] INFO  i.a.AntMediaApplicationAdapter - WebRTCAppEE started
2021-06-29 12:26:32,027 [vert.x-eventloop-thread-5] INFO  i.a.AntMediaApplicationAdapter - Stream source size: 0
2021-06-29 12:26:32,028 [vert.x-eventloop-thread-5] INFO  i.a.s.StreamFetcherManager - StreamFetcherSchedule job name 9
2021-06-29 12:26:32,028 [vert.x-eventloop-thread-5] INFO  i.a.AntMediaApplicationAdapter - socialEndpoints size: 0
2021-06-29 12:26:58,702 [http-nio2-0.0.0.0-5080-exec-10] INFO  io.antmedia.rest.RestServiceBase - Version Name 2.3.3.1 Version Type Enterprise Edition
2021-06-29 12:27:00,579 [http-nio2-0.0.0.0-5080-exec-9] INFO  io.antmedia.statistic.GPUUtils - cuda initialized 
2021-06-29 12:27:09,531 [http-nio2-0.0.0.0-5080-exec-5] WARN  i.a.AntMediaApplicationAdapter - app settings updated for LiveApp
2021-06-29 12:27:22,653 [pool-5-thread-1] INFO  org.red5.server.tomcat.WarDeployer - Deploy wars with app start
2021-06-29 12:27:24,653 [http-nio2-0.0.0.0-5080-exec-10] WARN  io.antmedia.rest.RestServiceBase -  endpoint does not exist in this app.
2021-06-29 12:27:43,360 [RTMPConnectionExecutor-1] INFO  i.a.e.streamapp.StreamApplication - W3C x-category:session x-event:connect c-ip:176.55.47.39 c-client-id:0
2021-06-29 12:27:43,607 [RTMPConnectionExecutor-1] INFO  i.a.s.AcceptOnlyStreamsInDataStore - AcceptOnlyStreamsInDataStore is not activated. Accepting all streams 077658164427168060405511
2021-06-29 12:27:43,628 [RTMPConnectionExecutor-1] INFO  org.red5.server.scope.BasicScope - ClientBroadcastStream already exists: org.red5.server.stream.ClientBroadcastStream@1207b895 new: org.red5.server.stream.ClientBroadcastStream@1207b895
2021-06-29 12:27:43,628 [RTMPConnectionExecutor-1] INFO  o.r.s.stream.ClientBroadcastStream - Stream start: 077658164427168060405511
2021-06-29 12:27:43,632 [RTMPConnectionExecutor-1] INFO  i.a.e.streamapp.StreamApplication - W3C x-category:stream x-event:publish c-ip:176.55.47.39 x-sname:0fd4e142-9812-46d0-873c-c36a1969309c x-name:077658164427168060405511
2021-06-29 12:27:43,650 [RTMPConnectionExecutor-1] INFO  io.antmedia.muxer.MuxAdaptor - vertx exist io.vertx.core.impl.VertxImpl@49c42ed8
2021-06-29 12:27:43,651 [RTMPConnectionExecutor-1] INFO  io.antmedia.muxer.MuxAdaptor - adding HLS Muxer for 077658164427168060405511
2021-06-29 12:27:45,606 [DeadlockGuardScheduler-2] WARN  o.r.s.n.r.ReceivedMessageTaskQueue - Interrupting unfinished active task [sessionId: 8ZGXKR2DJK9GC; packetNumber: 5; processing: true]
2021-06-29 12:27:45,621 [RTMPConnectionExecutor-2] INFO  o.red5.server.stream.AbstractStream - metadata read data type -->>>> core map
2021-06-29 12:27:45,992 [RTMPConnectionExecutor-1] ERROR o.r.server.service.ServiceInvoker - Error executing call: Service: null Method: publish Num Params: 2 0: 077658164427168060405511 1: live
java.lang.reflect.InvocationTargetException: null
    at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
    at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
    at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
    at java.base/java.lang.reflect.Method.invoke(Method.java:566)
    at org.red5.server.service.ServiceInvoker.invoke(ServiceInvoker.java:189)
    at org.red5.server.net.rtmp.RTMPHandler.invokeCall(RTMPHandler.java:221)
    at org.red5.server.net.rtmp.RTMPHandler.onCommand(RTMPHandler.java:317)
    at org.red5.server.net.rtmp.BaseRTMPHandler.messageReceived(BaseRTMPHandler.java:116)
    at org.red5.server.net.rtmp.ReceivedMessageTask.call(ReceivedMessageTask.java:72)
    at org.red5.server.net.rtmp.ReceivedMessageTask.call(ReceivedMessageTask.java:38)
    at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
    at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:515)
    at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
    at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
    at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
    at java.base/java.lang.Thread.run(Thread.java:829)
Caused by: java.lang.UnsatisfiedLinkError: java.nio.channels.FileLockInterruptionException
    at org.bytedeco.javacpp.Loader.loadLibrary(Loader.java:1739)
    at org.bytedeco.javacpp.Loader.load(Loader.java:1328)
    at org.bytedeco.javacpp.Loader.load(Loader.java:1132)
    at org.bytedeco.ffmpeg.global.avcodec.<clinit>(avcodec.java:18)
    at io.antmedia.muxer.Muxer.init(Muxer.java:297)
    at io.antmedia.muxer.Muxer.init(Muxer.java:224)
    at io.antmedia.muxer.HLSMuxer.init(HLSMuxer.java:139)
    at io.antmedia.muxer.MuxAdaptor.init(MuxAdaptor.java:359)
    at io.antmedia.enterprise.adaptive.EncoderAdaptor.init(EncoderAdaptor.java:178)
    at io.antmedia.muxer.MuxAdaptor.init(MuxAdaptor.java:289)
    at org.red5.server.stream.ClientBroadcastStream.startPublishing(ClientBroadcastStream.java:980)
    at org.red5.server.stream.StreamService.publish(StreamService.java:715)
    ... 16 common frames omitted
Caused by: java.nio.channels.FileLockInterruptionException: null
    at java.base/sun.nio.ch.FileChannelImpl.lock(FileChannelImpl.java:1138)
    at java.base/java.nio.channels.FileChannel.lock(FileChannel.java:1063)
    at org.bytedeco.javacpp.Loader.cacheResource(Loader.java:647)
    at org.bytedeco.javacpp.Loader.loadLibrary(Loader.java:1582)
    ... 27 common frames omitted
2021-06-29 12:27:45,994 [RTMPConnectionExecutor-1] WARN  o.r.s.net.rtmp.RTMPMinaConnection - Interrupted while waiting for write lock. State: connected
java.lang.InterruptedException: null
    at java.base/java.util.concurrent.locks.AbstractQueuedSynchronizer.tryAcquireSharedNanos(AbstractQueuedSynchronizer.java:1367)
    at java.base/java.util.concurrent.Semaphore.tryAcquire(Semaphore.java:415)
    at org.red5.server.net.rtmp.RTMPMinaConnection.write(RTMPMinaConnection.java:342)
    at org.red5.server.net.rtmp.Channel.write(Channel.java:139)
    at org.red5.server.net.rtmp.Channel.sendStatus(Channel.java:194)
    at org.red5.server.net.rtmp.RTMPHandler.onCommand(RTMPHandler.java:322)
    at org.red5.server.net.rtmp.BaseRTMPHandler.messageReceived(BaseRTMPHandler.java:116)
    at org.red5.server.net.rtmp.ReceivedMessageTask.call(ReceivedMessageTask.java:72)
    at org.red5.server.net.rtmp.ReceivedMessageTask.call(ReceivedMessageTask.java:38)
    at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
    at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:515)
    at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
    at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
    at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
    at java.base/java.lang.Thread.run(Thread.java:829)
2021-06-29 12:27:45,995 [RTMPConnectionExecutor-1] INFO  o.r.s.net.rtmp.RTMPMinaConnection - Session id: 8ZGXKR2DJK9GC in queue size: 0 pending msgs: 1 last ping/pong: 0
2021-06-29 12:27:45,995 [RTMPConnectionExecutor-1] INFO  o.r.s.net.rtmp.RTMPMinaConnection - Available permits - decoder: 1 encoder: 1
2021-06-29 12:27:56,041 [http-nio2-0.0.0.0-5080-exec-9] WARN  org.red5.server.scope.Scope - Requested scope: 077658164427168060405511 is not of IScope type: org.red5.server.scope.BroadcastScope
2021-06-29 12:27:56,041 [http-nio2-0.0.0.0-5080-exec-9] WARN  org.red5.server.scope.Scope - java.base/java.lang.Thread.getStackTrace(Thread.java:1602)
2021-06-29 12:27:56,042 [http-nio2-0.0.0.0-5080-exec-9] WARN  org.red5.server.scope.Scope - org.red5.server.scope.Scope.getScope(Scope.java:704)
2021-06-29 12:27:56,043 [http-nio2-0.0.0.0-5080-exec-9] WARN  org.red5.server.scope.Scope - io.antmedia.console.AdminApplication.getScopes(AdminApplication.java:265)
2021-06-29 12:27:56,043 [http-nio2-0.0.0.0-5080-exec-9] WARN  org.red5.server.scope.Scope - io.antmedia.console.AdminApplication.getScopes(AdminApplication.java:266)
2021-06-29 12:27:56,043 [http-nio2-0.0.0.0-5080-exec-9] WARN  org.red5.server.scope.Scope - io.antmedia.console.AdminApplication.getScope(AdminApplication.java:246)
2021-06-29 12:27:56,043 [http-nio2-0.0.0.0-5080-exec-9] WARN  org.red5.server.scope.Scope - io.antmedia.console.AdminApplication.getApplicationContext(AdminApplication.java:232)
2021-06-29 12:27:56,043 [http-nio2-0.0.0.0-5080-exec-9] WARN  org.red5.server.scope.Scope - io.antmedia.console.rest.CommonRestService.getSettings(CommonRestService.java:809)
2021-06-29 12:27:56,043 [http-nio2-0.0.0.0-5080-exec-9] WARN  org.red5.server.scope.Scope - io.antmedia.console.rest.RestServiceV2.getSettings(RestServiceV2.java:493)
2021-06-29 12:27:56,043 [http-nio2-0.0.0.0-5080-exec-9] WARN  org.red5.server.scope.Scope - java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
2021-06-29 12:27:56,043 [http-nio2-0.0.0.0-5080-exec-9] WARN  org.red5.server.scope.Scope - java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
2021-06-29 12:27:56,043 [http-nio2-0.0.0.0-5080-exec-9] WARN  org.red5.server.scope.Scope - java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
2021-06-29 12:27:56,043 [http-nio2-0.0.0.0-5080-exec-9] WARN  org.red5.server.scope.Scope - java.base/java.lang.reflect.Method.invoke(Method.java:566)
2021-06-29 12:27:56,043 [http-nio2-0.0.0.0-5080-exec-9] WARN  org.red5.server.scope.Scope - org.glassfish.jersey.server.model.internal.ResourceMethodInvocationHandlerFactory.lambda$static$0(ResourceMethodInvocationHandlerFactory.java:52)
2021-06-29 12:27:56,043 [http-nio2-0.0.0.0-5080-exec-9] WARN  org.red5.server.scope.Scope - org.glassfish.jersey.server.model.internal.AbstractJavaResourceMethodDispatcher$1.run(AbstractJavaResourceMethodDispatcher.java:124)
2021-06-29 12:27:56,043 [http-nio2-0.0.0.0-5080-exec-9] WARN  org.red5.server.scope.Scope - org.glassfish.jersey.server.model.internal.AbstractJavaResourceMethodDispatcher.invoke(AbstractJavaResourceMethodDispatcher.java:167)
2021-06-29 12:27:56,043 [http-nio2-0.0.0.0-5080-exec-9] WARN  org.red5.server.scope.Scope - org.glassfish.jersey.server.model.internal.JavaResourceMethodDispatcherProvider$TypeOutInvoker.doDispatch(JavaResourceMethodDispatcherProvider.java:219)
2021-06-29 12:27:56,043 [http-nio2-0.0.0.0-5080-exec-9] WARN  org.red5.server.scope.Scope - org.glassfish.jersey.server.model.internal.AbstractJavaResourceMethodDispatcher.dispatch(AbstractJavaResourceMethodDispatcher.java:79)
2021-06-29 12:27:56,043 [http-nio2-0.0.0.0-5080-exec-9] WARN  org.red5.server.scope.Scope - org.glassfish.jersey.server.model.ResourceMethodInvoker.invoke(ResourceMethodInvoker.java:469)
2021-06-29 12:27:56,043 [http-nio2-0.0.0.0-5080-exec-9] WARN  org.red5.server.scope.Scope - org.glassfish.jersey.server.model.ResourceMethodInvoker.apply(ResourceMethodInvoker.java:391)
2021-06-29 12:27:56,043 [http-nio2-0.0.0.0-5080-exec-9] WARN  org.red5.server.scope.Scope - org.glassfish.jersey.server.model.ResourceMethodInvoker.apply(ResourceMethodInvoker.java:80)
2021-06-29 12:27:56,043 [http-nio2-0.0.0.0-5080-exec-9] WARN  org.red5.server.scope.Scope - org.glassfish.jersey.server.ServerRuntime$1.run(ServerRuntime.java:253)
2021-06-29 12:27:56,043 [http-nio2-0.0.0.0-5080-exec-9] WARN  org.red5.server.scope.Scope - org.glassfish.jersey.internal.Errors$1.call(Errors.java:248)
2021-06-29 12:27:56,044 [http-nio2-0.0.0.0-5080-exec-9] WARN  org.red5.server.scope.Scope - org.glassfish.jersey.internal.Errors$1.call(Errors.java:244)
2021-06-29 12:27:56,044 [http-nio2-0.0.0.0-5080-exec-9] WARN  org.red5.server.scope.Scope - org.glassfish.jersey.internal.Errors.process(Errors.java:292)
2021-06-29 12:27:56,044 [http-nio2-0.0.0.0-5080-exec-9] WARN  org.red5.server.scope.Scope - org.glassfish.jersey.internal.Errors.process(Errors.java:274)
2021-06-29 12:27:56,044 [http-nio2-0.0.0.0-5080-exec-9] WARN  org.red5.server.scope.Scope - org.glassfish.jersey.internal.Errors.process(Errors.java:244)
2021-06-29 12:27:56,044 [http-nio2-0.0.0.0-5080-exec-9] WARN  org.red5.server.scope.Scope - org.glassfish.jersey.process.internal.RequestScope.runInScope(RequestScope.java:265)
2021-06-29 12:27:56,044 [http-nio2-0.0.0.0-5080-exec-9] WARN  org.red5.server.scope.Scope - org.glassfish.jersey.server.ServerRuntime.process(ServerRuntime.java:232)
2021-06-29 12:27:56,044 [http-nio2-0.0.0.0-5080-exec-9] WARN  org.red5.server.scope.Scope - org.glassfish.jersey.server.ApplicationHandler.handle(ApplicationHandler.java:680)
2021-06-29 12:27:56,044 [http-nio2-0.0.0.0-5080-exec-9] WARN  org.red5.server.scope.Scope - org.glassfish.jersey.servlet.WebComponent.serviceImpl(WebComponent.java:394)
2021-06-29 12:27:56,044 [http-nio2-0.0.0.0-5080-exec-9] WARN  org.red5.server.scope.Scope - org.glassfish.jersey.servlet.WebComponent.service(WebComponent.java:346)
2021-06-29 12:27:56,044 [http-nio2-0.0.0.0-5080-exec-9] WARN  org.red5.server.scope.Scope - org.glassfish.jersey.servlet.ServletContainer.service(ServletContainer.java:366)
2021-06-29 12:27:56,044 [http-nio2-0.0.0.0-5080-exec-9] WARN  org.red5.server.scope.Scope - org.glassfish.jersey.servlet.ServletContainer.service(ServletContainer.java:319)
2021-06-29 12:27:56,044 [http-nio2-0.0.0.0-5080-exec-9] WARN  org.red5.server.scope.Scope - org.glassfish.jersey.servlet.ServletContainer.service(ServletContainer.java:205)
2021-06-29 12:27:56,044 [http-nio2-0.0.0.0-5080-exec-9] WARN  org.red5.server.scope.Scope - org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:231)
2021-06-29 12:27:56,044 [http-nio2-0.0.0.0-5080-exec-9] WARN  org.red5.server.scope.Scope - org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:166)
2021-06-29 12:27:56,044 [http-nio2-0.0.0.0-5080-exec-9] WARN  org.red5.server.scope.Scope - org.apache.tomcat.websocket.server.WsFilter.doFilter(WsFilter.java:52)
2021-06-29 12:27:56,044 [http-nio2-0.0.0.0-5080-exec-9] WARN  org.red5.server.scope.Scope - org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:193)
2021-06-29 12:27:56,044 [http-nio2-0.0.0.0-5080-exec-9] WARN  org.red5.server.scope.Scope - org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:166)
2021-06-29 12:27:56,044 [http-nio2-0.0.0.0-5080-exec-9] WARN  org.red5.server.scope.Scope - io.antmedia.console.rest.AuthenticationFilter.doFilter(AuthenticationFilter.java:78)
2021-06-29 12:27:56,044 [http-nio2-0.0.0.0-5080-exec-9] WARN  org.red5.server.scope.Scope - org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:193)
2021-06-29 12:27:56,044 [http-nio2-0.0.0.0-5080-exec-9] WARN  org.red5.server.scope.Scope - org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:166)
2021-06-29 12:27:56,045 [http-nio2-0.0.0.0-5080-exec-9] WARN  org.red5.server.scope.Scope - io.antmedia.filter.IPFilterDashboard.doFilter(IPFilterDashboard.java:23)
2021-06-29 12:27:56,045 [http-nio2-0.0.0.0-5080-exec-9] WARN  org.red5.server.scope.Scope - org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:193)
2021-06-29 12:27:56,045 [http-nio2-0.0.0.0-5080-exec-9] WARN  org.red5.server.scope.Scope - org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:166)
2021-06-29 12:27:56,045 [http-nio2-0.0.0.0-5080-exec-9] WARN  org.red5.server.scope.Scope - org.apache.catalina.filters.CorsFilter.handleNonCORS(CorsFilter.java:364)
2021-06-29 12:27:56,045 [http-nio2-0.0.0.0-5080-exec-9] WARN  org.red5.server.scope.Scope - org.apache.catalina.filters.CorsFilter.doFilter(CorsFilter.java:170)
2021-06-29 12:27:56,045 [http-nio2-0.0.0.0-5080-exec-9] WARN  org.red5.server.scope.Scope - org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:193)
2021-06-29 12:27:56,045 [http-nio2-0.0.0.0-5080-exec-9] WARN  org.red5.server.scope.Scope - org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:166)
2021-06-29 12:27:56,045 [http-nio2-0.0.0.0-5080-exec-9] WARN  org.red5.server.scope.Scope - org.red5.logging.LoggerContextFilter.doFilter(LoggerContextFilter.java:84)
2021-06-29 12:27:56,045 [http-nio2-0.0.0.0-5080-exec-9] WARN  org.red5.server.scope.Scope - org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:193)
2021-06-29 12:27:56,045 [http-nio2-0.0.0.0-5080-exec-9] WARN  org.red5.server.scope.Scope - org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:166)
2021-06-29 12:27:56,045 [http-nio2-0.0.0.0-5080-exec-9] WARN  org.red5.server.scope.Scope - org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:199)
2021-06-29 12:27:56,045 [http-nio2-0.0.0.0-5080-exec-9] WARN  org.red5.server.scope.Scope - org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:97)
2021-06-29 12:27:56,045 [http-nio2-0.0.0.0-5080-exec-9] WARN  org.red5.server.scope.Scope - org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:543)
2021-06-29 12:27:56,045 [http-nio2-0.0.0.0-5080-exec-9] WARN  org.red5.server.scope.Scope - org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:143)
2021-06-29 12:27:56,045 [http-nio2-0.0.0.0-5080-exec-9] WARN  org.red5.server.scope.Scope - org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:81)
2021-06-29 12:27:56,045 [http-nio2-0.0.0.0-5080-exec-9] WARN  org.red5.server.scope.Scope - org.apache.catalina.valves.AbstractAccessLogValve.invoke(AbstractAccessLogValve.java:690)
2021-06-29 12:27:56,045 [http-nio2-0.0.0.0-5080-exec-9] WARN  org.red5.server.scope.Scope - org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:78)
2021-06-29 12:27:56,045 [http-nio2-0.0.0.0-5080-exec-9] WARN  org.red5.server.scope.Scope - org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:343)
2021-06-29 12:27:56,045 [http-nio2-0.0.0.0-5080-exec-9] WARN  org.red5.server.scope.Scope - org.apache.coyote.http11.Http11Processor.service(Http11Processor.java:616)
2021-06-29 12:27:56,046 [http-nio2-0.0.0.0-5080-exec-9] WARN  org.red5.server.scope.Scope - org.apache.coyote.AbstractProcessorLight.process(AbstractProcessorLight.java:65)
2021-06-29 12:27:56,046 [http-nio2-0.0.0.0-5080-exec-9] WARN  org.red5.server.scope.Scope - org.apache.coyote.AbstractProtocol$ConnectionHandler.process(AbstractProtocol.java:818)
2021-06-29 12:27:56,046 [http-nio2-0.0.0.0-5080-exec-9] WARN  org.red5.server.scope.Scope - org.apache.tomcat.util.net.Nio2Endpoint$SocketProcessor.doRun(Nio2Endpoint.java:1620)
2021-06-29 12:27:56,046 [http-nio2-0.0.0.0-5080-exec-9] WARN  org.red5.server.scope.Scope - org.apache.tomcat.util.net.SocketProcessorBase.run(SocketProcessorBase.java:49)
2021-06-29 12:27:56,046 [http-nio2-0.0.0.0-5080-exec-9] WARN  org.red5.server.scope.Scope - org.apache.tomcat.util.net.AbstractEndpoint.processSocket(AbstractEndpoint.java:1082)
2021-06-29 12:27:56,046 [http-nio2-0.0.0.0-5080-exec-9] WARN  org.red5.server.scope.Scope - org.apache.tomcat.util.net.Nio2Endpoint$Nio2SocketWrapper$2.completed(Nio2Endpoint.java:565)
2021-06-29 12:27:56,046 [http-nio2-0.0.0.0-5080-exec-9] WARN  org.red5.server.scope.Scope - org.apache.tomcat.util.net.Nio2Endpoint$Nio2SocketWrapper$2.completed(Nio2Endpoint.java:543)
2021-06-29 12:27:56,046 [http-nio2-0.0.0.0-5080-exec-9] WARN  org.red5.server.scope.Scope - java.base/sun.nio.ch.Invoker.invokeUnchecked(Invoker.java:127)
2021-06-29 12:27:56,046 [http-nio2-0.0.0.0-5080-exec-9] WARN  org.red5.server.scope.Scope - java.base/sun.nio.ch.Invoker$2.run(Invoker.java:219)
2021-06-29 12:27:56,046 [http-nio2-0.0.0.0-5080-exec-9] WARN  org.red5.server.scope.Scope - java.base/sun.nio.ch.AsynchronousChannelGroupImpl$1.run(AsynchronousChannelGroupImpl.java:112)
2021-06-29 12:27:56,046 [http-nio2-0.0.0.0-5080-exec-9] WARN  org.red5.server.scope.Scope - java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
2021-06-29 12:27:56,046 [http-nio2-0.0.0.0-5080-exec-9] WARN  org.red5.server.scope.Scope - java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
2021-06-29 12:27:56,046 [http-nio2-0.0.0.0-5080-exec-9] WARN  org.red5.server.scope.Scope - org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:61)
2021-06-29 12:27:56,046 [http-nio2-0.0.0.0-5080-exec-9] WARN  org.red5.server.scope.Scope - java.base/java.lang.Thread.run(Thread.java:829)
2021-06-29 12:28:12,647 [NioProcessor-2] INFO  o.r.s.stream.ClientBroadcastStream - Checking mux adaptor to stop 077658164427168060405511
2021-06-29 12:28:12,648 [NioProcessor-2] INFO  o.r.s.stream.ClientBroadcastStream - Mux Adaptor stop called 077658164427168060405511
2021-06-29 12:28:12,652 [NioProcessor-2] INFO  i.a.e.streamapp.StreamApplication - W3C x-category:stream x-event:unpublish c-ip:176.55.47.39 cs-bytes:3232752 sc-bytes:6079 x-sname:0fd4e142-9812-46d0-873c-c36a1969309c x-file-length:29 x-name:077658164427168060405511
2021-06-29 12:28:12,653 [NioProcessor-2] INFO  i.a.e.streamapp.StreamApplication - W3C x-category:session x-event:disconnect c-ip:176.55.47.39 c-client-id:0
2021-06-29 12:28:12,654 [vert.x-worker-thread-0] INFO  i.a.AntMediaApplicationAdapter - Closing broadcast stream id: 077658164427168060405511
2021-06-29 12:28:12,756 [vert.x-worker-thread-0] INFO  i.antmedia.statistic.HlsViewerStats - Reset HLS Stream ID: 077658164427168060405511 remove failed or null
2021-06-29 12:28:15,080 [RTMPConnectionExecutor-1] INFO  i.a.e.streamapp.StreamApplication - W3C x-category:session x-event:connect c-ip:176.55.47.39 c-client-id:1
2021-06-29 12:28:15,306 [RTMPConnectionExecutor-1] INFO  i.a.s.AcceptOnlyStreamsInDataStore - AcceptOnlyStreamsInDataStore is not activated. Accepting all streams 077658164427168060405511
2021-06-29 12:28:15,307 [RTMPConnectionExecutor-1] INFO  org.red5.server.scope.BasicScope - ClientBroadcastStream already exists: org.red5.server.stream.ClientBroadcastStream@6d8e5c74 new: org.red5.server.stream.ClientBroadcastStream@6d8e5c74
2021-06-29 12:28:15,308 [RTMPConnectionExecutor-1] INFO  o.r.s.stream.ClientBroadcastStream - Stream start: 077658164427168060405511
2021-06-29 12:28:15,308 [RTMPConnectionExecutor-1] INFO  i.a.e.streamapp.StreamApplication - W3C x-category:stream x-event:publish c-ip:176.55.47.39 x-sname:c028262d-3c66-40a1-b775-67be001caca0 x-name:077658164427168060405511
2021-06-29 12:28:15,309 [RTMPConnectionExecutor-1] INFO  io.antmedia.muxer.MuxAdaptor - vertx exist io.vertx.core.impl.VertxImpl@49c42ed8
2021-06-29 12:28:15,309 [RTMPConnectionExecutor-1] INFO  io.antmedia.muxer.MuxAdaptor - adding HLS Muxer for 077658164427168060405511
2021-06-29 12:28:15,310 [RTMPConnectionExecutor-1] ERROR o.r.server.service.ServiceInvoker - Error executing call: Service: null Method: publish Num Params: 2 0: 077658164427168060405511 1: live
java.lang.reflect.InvocationTargetException: null
    at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
    at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
    at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
    at java.base/java.lang.reflect.Method.invoke(Method.java:566)
    at org.red5.server.service.ServiceInvoker.invoke(ServiceInvoker.java:189)
    at org.red5.server.net.rtmp.RTMPHandler.invokeCall(RTMPHandler.java:221)
    at org.red5.server.net.rtmp.RTMPHandler.onCommand(RTMPHandler.java:317)
    at org.red5.server.net.rtmp.BaseRTMPHandler.messageReceived(BaseRTMPHandler.java:116)
    at org.red5.server.net.rtmp.ReceivedMessageTask.call(ReceivedMessageTask.java:72)
    at org.red5.server.net.rtmp.ReceivedMessageTask.call(ReceivedMessageTask.java:38)
    at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
    at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:515)
    at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
    at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
    at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
    at java.base/java.lang.Thread.run(Thread.java:829)
Caused by: java.lang.NoClassDefFoundError: Could not initialize class org.bytedeco.ffmpeg.global.avcodec
    at io.antmedia.muxer.Muxer.init(Muxer.java:297)
    at io.antmedia.muxer.Muxer.init(Muxer.java:224)
    at io.antmedia.muxer.HLSMuxer.init(HLSMuxer.java:139)
    at io.antmedia.muxer.MuxAdaptor.init(MuxAdaptor.java:359)
    at io.antmedia.enterprise.adaptive.EncoderAdaptor.init(EncoderAdaptor.java:178)
    at io.antmedia.muxer.MuxAdaptor.init(MuxAdaptor.java:289)
    at org.red5.server.stream.ClientBroadcastStream.startPublishing(ClientBroadcastStream.java:980)
    at org.red5.server.stream.StreamService.publish(StreamService.java:715)
    ... 16 common frames omitted
2021-06-29 12:28:15,399 [RTMPConnectionExecutor-3] INFO  o.red5.server.stream.AbstractStream - metadata read data type -->>>> core map
justinh24 commented 2 years ago

In order for RTMP to work properly on an AWS GPU instance, I first have to configure and start the instance. Then I have to attempt to send an RTMP stream (which fails with the logs above) and then restart the instance. It will then work from that point forward. Just restarting the instance without first sending an RTMP stream does not fix the issue.

yashtandon113 commented 2 years ago

@justinh24 Thanks a lot for reporting this issue. We have checked and able to reproduce the issue with AWS images and created the new git hub issue for this. Our team will look into the issue and update the status.

mekya commented 2 years ago

I think the problem is in the first starting up the instance.

io.antmedia.console.rest.CommonRestService.addInitialUser

Check the logs -> ant-media-server.log