Closed jmacauley closed 10 years ago
2014-06-25 20:42:21,891 DEBUG application play-akka.actor.default-dispatcher-264 - received SOAP message /nsi-v2/ConnectionServiceProvider from 127.0.0.1 with content-type Some(text/xml) <soapenv:Envelope xmlns:xs="http://www.w3.org/2001/XMLSchema" xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance" xmlns:gns="http://nordu.net/namespaces/2013/12/gnsbod" xmlns:saml="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:type="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:head="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/">
<soapenv:Header>
<head:nsiHeader>
<protocolVersion>application/vnd.ogf.nsi.cs.v2.provider+soap</protocolVersion>
<correlationId>urn:uuid:d0735d1a-6ee8-43ac-b467-7c1ac7233a2b</correlationId>
<requesterNSA>urn:ogf:network:es.net:2013:nsa:nsi-requester</requesterNSA>
<providerNSA>urn:ogf:network:es.net:2013:nsa:nsi-aggr-west</providerNSA>
<replyTo>https://nsi-aggr-west.es.net/requester/reply</replyTo>
<gns:ConnectionTrace>
<Connection index="0">urn:ogf:network:es.net:2013:nsa:nsi-requester:noId</Connection>
</gns:ConnectionTrace>
</head:nsiHeader>
</soapenv:Header>
<soapenv:Body>
<type:reserve>
<globalReservationId>urn:uuid:2888ca60-e612-11e3-ac10-0800200c9998</globalReservationId>
<description>Test: Terminate after end time</description>
<criteria version="1">
<schedule>
<startTime>2014-06-25T20:45:00.000-07:00</startTime>
<endTime>2014-06-25T20:50:00.000-07:00</endTime>
</schedule>
<serviceType>http://services.ogf.org/nsi/2013/12/descriptions/EVTS.A-GOLE</serviceType>
<p2p:p2ps xmlns:p2p="http://schemas.ogf.org/nsi/2013/12/services/point2point">
<capacity>100</capacity>
<directionality>Bidirectional</directionality>
<symmetricPath>true</symmetricPath>
<sourceSTP>urn:ogf:network:es.net:2013:ps:sunn:1?vlan=1780</sourceSTP>
<destSTP>urn:ogf:network:manlan.internet2.edu:2013:netherlight?vlan=1780</destSTP>
<parameter type="protection">UNPROTECTED</parameter>
</p2p:p2ps>
</criteria>
</type:reserve>
</soapenv:Body>
</soapenv:Envelope> -
2014-06-25 20:42:21,905 DEBUG application play-akka.actor.default-dispatcher-264 - SOAP message parse result Success([#document: null]) -
2014-06-25 20:42:21,910 DEBUG application play-internal-execution-context-1 - Received (/nsi-v2/ConnectionServiceProvider): Success(NsiProviderMessage(NsiHeaders(urn:uuid:d0735d1a-6ee8-43ac-b467-7c1ac7233a2b,urn:ogf:network:es.net:2013:nsa:nsi-requester,urn:ogf:network:es.net:2013:nsa:nsi-aggr-west,Some(https://nsi-aggr-west.es.net/requester/reply),application/vnd.ogf.nsi.cs.v2.provider+soap,List(),List(net.nordu.namespaces._2013._12.gnsbod.ConnectionType@6c106d2[value=urn:ogf:network:es.net:2013:nsa:nsi-requester:noId, index=0])),InitialReserve(org.ogf.schemas.nsi._2013._12.connection.types.ReserveType@66446f80[connectionId=<null>, globalReservationId=urn:uuid:2888ca60-e612-11e3-ac10-0800200c9998, description=Test: Terminate after end time, criteria=org.ogf.schemas.nsi._2013._12.connection.types.ReservationRequestCriteriaType@3e4f57ef[schedule=org.ogf.schemas.nsi._2013._12.connection.types.ScheduleType@222b993e[startTime=2014-06-25T20:45:00.000-07:00, endTime=2014-06-25T20:50:00.000-07:00], serviceType=http://services.ogf.org/nsi/2013/12/descriptions/EVTS.A-GOLE, any={<{http://schemas.ogf.org/nsi/2013/12/services/point2point}p2ps[org.ogf.schemas.nsi._2013._12.services.point2point.P2PServiceBaseType@2cd2ec3f[capacity=100, directionality=BIDIRECTIONAL, symmetricPath=true, sourceSTP=urn:ogf:network:es.net:2013:ps:sunn:1?vlan=1780, destSTP=urn:ogf:network:manlan.internet2.edu:2013:netherlight?vlan=1780, ero=<null>, parameter={org.ogf.schemas.nsi._2013._12.services.types.TypeValueType@692fae4a[value=UNPROTECTED, type=protection]}, any=<null>]]>}, version=1]],org.ogf.schemas.nsi._2013._12.connection.types.ReservationConfirmCriteriaType@2d1b7caf[schedule=org.ogf.schemas.nsi._2013._12.connection.types.ScheduleType@222b993e[startTime=2014-06-25T20:45:00.000-07:00, endTime=2014-06-25T20:50:00.000-07:00], serviceType=http://services.ogf.org/nsi/2013/12/descriptions/EVTS.A-GOLE, any={<{http://schemas.ogf.org/nsi/2013/12/services/point2point}p2ps[org.ogf.schemas.nsi._2013._12.services.point2point.P2PServiceBaseType@2cd2ec3f[capacity=100, directionality=BIDIRECTIONAL, symmetricPath=true, sourceSTP=urn:ogf:network:es.net:2013:ps:sunn:1?vlan=1780, destSTP=urn:ogf:network:manlan.internet2.edu:2013:netherlight?vlan=1780, ero=<null>, parameter={org.ogf.schemas.nsi._2013._12.services.types.TypeValueType@692fae4a[value=UNPROTECTED, type=protection]}, any=<null>]]>}, version=1],org.ogf.schemas.nsi._2013._12.services.point2point.P2PServiceBaseType@2cd2ec3f[capacity=100, directionality=BIDIRECTIONAL, symmetricPath=true, sourceSTP=urn:ogf:network:es.net:2013:ps:sunn:1?vlan=1780, destSTP=urn:ogf:network:manlan.internet2.edu:2013:netherlight?vlan=1780, ero=<null>, parameter={org.ogf.schemas.nsi._2013._12.services.types.TypeValueType@692fae4a[value=UNPROTECTED, type=protection]}, any=<null>]))) -
2014-06-25 20:42:21,950 DEBUG application application-akka.actor.default-dispatcher-230 - state change from InitialReservationState to PathComputationState -
2014-06-25 20:42:22,022 DEBUG application application-akka.actor.default-dispatcher-230 - Scheduling Delete for execution after 86399927 milliseconds -
2014-06-25 20:42:22,024 INFO application application-akka.actor.default-dispatcher-243 - Sending request to pce (http://localhost:8400/paths/find): {"correlationId":"urn:uuid:89a9e922-440c-41d3-896d-1bc51ca4ba38","replyTo":{"url":"https://nsi-aggr-west.es.net/pce/reply","mediaType":"application/json"},"algorithm":"TREE","startTime":"2014-06-25T20:45:00.000-07:00","endTime":"2014-06-25T20:50:00.000-07:00","constraints":[],"serviceType":"http://services.ogf.org/nsi/2013/12/descriptions/EVTS.A-GOLE","p.p2ps":[{"capacity":100,"directionality":"Bidirectional","symmetricPath":true,"sourceSTP":"urn:ogf:network:es.net:2013:ps:sunn:1?vlan=1780","destSTP":"urn:ogf:network:manlan.internet2.edu:2013:netherlight?vlan=1780"}],"trace":[{"index":0,"value":"urn:ogf:network:es.net:2013:nsa:nsi-requester:noId"}]} -
2014-06-25 20:42:22,028 DEBUG application play-akka.actor.default-dispatcher-267 - Ack 127.0.0.1 with Success(<?xml version="1.0" encoding="UTF-8" standalone="no"?><soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/"><soapenv:Header><ns7:nsiHeader xmlns:ns2="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns3="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:ns4="http://www.w3.org/2001/04/xmlenc#" xmlns:ns5="http://www.w3.org/2000/09/xmldsig#" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point" xmlns:ns9="http://nordu.net/namespaces/2013/12/gnsbod"><protocolVersion>application/vnd.ogf.nsi.cs.v2.provider+soap</protocolVersion><correlationId>urn:uuid:d0735d1a-6ee8-43ac-b467-7c1ac7233a2b</correlationId><requesterNSA>urn:ogf:network:es.net:2013:nsa:nsi-requester</requesterNSA><providerNSA>urn:ogf:network:es.net:2013:nsa:nsi-aggr-west</providerNSA></ns7:nsiHeader></soapenv:Header><soapenv:Body><ns2:reserveResponse xmlns:ns2="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns3="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:ns4="http://www.w3.org/2001/04/xmlenc#" xmlns:ns5="http://www.w3.org/2000/09/xmldsig#" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point" xmlns:ns9="http://nordu.net/namespaces/2013/12/gnsbod"><connectionId>494e60a6-db7f-4285-9e66-500289299731</connectionId></ns2:reserveResponse></soapenv:Body></soapenv:Envelope>) -
2014-06-25 20:42:22,537 INFO application play-akka.actor.default-dispatcher-267 - Pce reply: PathComputationConfirmed(urn:uuid:89a9e922-440c-41d3-896d-1bc51ca4ba38,List(ComputedSegment(ProviderEndPoint(urn:ogf:network:es.net:2013:nsa,https://oscars.es.net/ConnectionService),ServiceType(http://services.ogf.org/nsi/2013/12/descriptions/EVTS.A-GOLE,org.ogf.schemas.nsi._2013._12.services.point2point.P2PServiceBaseType@522e209f[capacity=100, directionality=BIDIRECTIONAL, symmetricPath=true, sourceSTP=urn:ogf:network:es.net:2013:ps:sunn:1?vlan=1780, destSTP=urn:ogf:network:es.net:2013:manlan:aofa:1?vlan=1780, ero=<null>, parameter=<null>, any=<null>])), ComputedSegment(ProviderEndPoint(urn:ogf:network:manlan.internet2.edu:2013:nsa,https://oscars.manlan.internet2.edu:8500/ConnectionServiceProvider),ServiceType(http://services.ogf.org/nsi/2013/12/descriptions/EVTS.A-GOLE,org.ogf.schemas.nsi._2013._12.services.point2point.P2PServiceBaseType@1bf6bed2[capacity=100, directionality=BIDIRECTIONAL, symmetricPath=true, sourceSTP=urn:ogf:network:manlan.internet2.edu:2013:es?vlan=1780, destSTP=urn:ogf:network:manlan.internet2.edu:2013:netherlight?vlan=1780, ero=<null>, parameter=<null>, any=<null>])))) -
2014-06-25 20:42:22,538 DEBUG application application-akka.actor.default-dispatcher-243 - state change from PathComputationState to CheckingReservationState -
2014-06-25 20:42:22,598 DEBUG application application-akka.actor.default-dispatcher-243 - Scheduling Delete for execution after 86399939 milliseconds -
2014-06-25 20:42:22,601 DEBUG application application-akka.actor.default-dispatcher-243 - Sending provider urn:ogf:network:es.net:2013:nsa at https://oscars.es.net/ConnectionService the SOAP message: Success(<?xml version="1.0" encoding="UTF-8" standalone="no"?><soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/"><soapenv:Header><ns7:nsiHeader xmlns:ns2="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns3="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:ns4="http://www.w3.org/2001/04/xmlenc#" xmlns:ns5="http://www.w3.org/2000/09/xmldsig#" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point" xmlns:ns9="http://nordu.net/namespaces/2013/12/gnsbod"><protocolVersion>application/vnd.ogf.nsi.cs.v2.provider+soap</protocolVersion><correlationId>urn:uuid:51de9878-41ac-481b-bc82-5691b99b19c1</correlationId><requesterNSA>urn:ogf:network:es.net:2013:nsa:nsi-aggr-west</requesterNSA><providerNSA>urn:ogf:network:es.net:2013:nsa</providerNSA><replyTo>https://nsi-aggr-west.es.net/nsi-v2/ConnectionServiceRequester</replyTo><ns9:ConnectionTrace><Connection index="1">urn:ogf:network:es.net:2013:nsa:nsi-aggr-west:494e60a6-db7f-4285-9e66-500289299731</Connection><Connection index="0">urn:ogf:network:es.net:2013:nsa:nsi-requester:noId</Connection></ns9:ConnectionTrace></ns7:nsiHeader></soapenv:Header><soapenv:Body><ns2:reserve xmlns:ns2="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns3="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:ns4="http://www.w3.org/2001/04/xmlenc#" xmlns:ns5="http://www.w3.org/2000/09/xmldsig#" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point" xmlns:ns9="http://nordu.net/namespaces/2013/12/gnsbod"><globalReservationId>urn:uuid:2888ca60-e612-11e3-ac10-0800200c9998</globalReservationId><description>Test: Terminate after end time</description><criteria version="1"><schedule><startTime>2014-06-25T20:45:00.000-07:00</startTime><endTime>2014-06-25T20:50:00.000-07:00</endTime></schedule><serviceType>http://services.ogf.org/nsi/2013/12/descriptions/EVTS.A-GOLE</serviceType><ns8:p2ps><capacity>100</capacity><directionality>Bidirectional</directionality><symmetricPath>true</symmetricPath><sourceSTP>urn:ogf:network:es.net:2013:ps:sunn:1?vlan=1780</sourceSTP><destSTP>urn:ogf:network:es.net:2013:manlan:aofa:1?vlan=1780</destSTP></ns8:p2ps></criteria></ns2:reserve></soapenv:Body></soapenv:Envelope>) -
2014-06-25 20:42:22,653 DEBUG application application-akka.actor.default-dispatcher-243 - Sending provider urn:ogf:network:manlan.internet2.edu:2013:nsa at https://oscars.manlan.internet2.edu:8500/ConnectionServiceProvider the SOAP message: Success(<?xml version="1.0" encoding="UTF-8" standalone="no"?><soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/"><soapenv:Header><ns7:nsiHeader xmlns:ns2="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns3="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:ns4="http://www.w3.org/2001/04/xmlenc#" xmlns:ns5="http://www.w3.org/2000/09/xmldsig#" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point" xmlns:ns9="http://nordu.net/namespaces/2013/12/gnsbod"><protocolVersion>application/vnd.ogf.nsi.cs.v2.provider+soap</protocolVersion><correlationId>urn:uuid:213c1379-6b96-4f73-a0dd-ebe80af96f09</correlationId><requesterNSA>urn:ogf:network:es.net:2013:nsa:nsi-aggr-west</requesterNSA><providerNSA>urn:ogf:network:manlan.internet2.edu:2013:nsa</providerNSA><replyTo>https://nsi-aggr-west.es.net/nsi-v2/ConnectionServiceRequester</replyTo><ns9:ConnectionTrace><Connection index="1">urn:ogf:network:es.net:2013:nsa:nsi-aggr-west:494e60a6-db7f-4285-9e66-500289299731</Connection><Connection index="0">urn:ogf:network:es.net:2013:nsa:nsi-requester:noId</Connection></ns9:ConnectionTrace></ns7:nsiHeader></soapenv:Header><soapenv:Body><ns2:reserve xmlns:ns2="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns3="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:ns4="http://www.w3.org/2001/04/xmlenc#" xmlns:ns5="http://www.w3.org/2000/09/xmldsig#" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point" xmlns:ns9="http://nordu.net/namespaces/2013/12/gnsbod"><globalReservationId>urn:uuid:2888ca60-e612-11e3-ac10-0800200c9998</globalReservationId><description>Test: Terminate after end time</description><criteria version="1"><schedule><startTime>2014-06-25T20:45:00.000-07:00</startTime><endTime>2014-06-25T20:50:00.000-07:00</endTime></schedule><serviceType>http://services.ogf.org/nsi/2013/12/descriptions/EVTS.A-GOLE</serviceType><ns8:p2ps><capacity>100</capacity><directionality>Bidirectional</directionality><symmetricPath>true</symmetricPath><sourceSTP>urn:ogf:network:manlan.internet2.edu:2013:es?vlan=1780</sourceSTP><destSTP>urn:ogf:network:manlan.internet2.edu:2013:netherlight?vlan=1780</destSTP></ns8:p2ps></criteria></ns2:reserve></soapenv:Body></soapenv:Envelope>) -
2014-06-25 20:42:23,096 DEBUG application play-akka.actor.default-dispatcher-267 - Parsing SOAP ack (200) from urn:ogf:network:es.net:2013:nsa at https://oscars.es.net/ConnectionService: <soap:Envelope xmlns:soap="http://schemas.xmlsoap.org/soap/envelope/"><soap:Header><ns6:nsiHeader xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns5="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns4="http://www.w3.org/2000/09/xmldsig#" xmlns:ns3="http://www.w3.org/2001/04/xmlenc#" xmlns:ns2="urn:oasis:names:tc:SAML:2.0:assertion"><protocolVersion>application/vnd.ogf.nsi.cs.v2.provider+soap</protocolVersion><correlationId>urn:uuid:51de9878-41ac-481b-bc82-5691b99b19c1</correlationId><requesterNSA>urn:ogf:network:es.net:2013:nsa:nsi-aggr-west</requesterNSA><providerNSA>urn:ogf:network:es.net:2013:nsa</providerNSA></ns6:nsiHeader></soap:Header><soap:Body><ns5:reserveResponse xmlns:ns2="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:ns3="http://www.w3.org/2001/04/xmlenc#" xmlns:ns4="http://www.w3.org/2000/09/xmldsig#" xmlns:ns5="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point"><connectionId>urn:uuid:c2944c2e-c464-4c76-805d-f0f57cb7981b</connectionId></ns5:reserveResponse></soap:Body></soap:Envelope> -
2014-06-25 20:42:23,101 DEBUG application play-akka.actor.default-dispatcher-267 - Received ack from urn:ogf:network:es.net:2013:nsa at https://oscars.es.net/ConnectionService: NsiProviderMessage(NsiHeaders(urn:uuid:51de9878-41ac-481b-bc82-5691b99b19c1,urn:ogf:network:es.net:2013:nsa:nsi-aggr-west,urn:ogf:network:es.net:2013:nsa,None,application/vnd.ogf.nsi.cs.v2.provider+soap,List(),List()),ReserveResponse(urn:uuid:c2944c2e-c464-4c76-805d-f0f57cb7981b)) -
2014-06-25 20:42:23,102 DEBUG application application-akka.actor.default-dispatcher-243 - state change from CheckingReservationState to CheckingReservationState -
2014-06-25 20:42:23,136 DEBUG application application-akka.actor.default-dispatcher-243 - Scheduling Delete for execution after 86399965 milliseconds -
2014-06-25 20:42:23,278 DEBUG application play-akka.actor.default-dispatcher-267 - Parsing SOAP ack (200) from urn:ogf:network:manlan.internet2.edu:2013:nsa at https://oscars.manlan.internet2.edu:8500/ConnectionServiceProvider: <soap:Envelope xmlns:soap="http://schemas.xmlsoap.org/soap/envelope/"><soap:Header><ns6:nsiHeader xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns5="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns4="http://www.w3.org/2000/09/xmldsig#" xmlns:ns3="http://www.w3.org/2001/04/xmlenc#" xmlns:ns2="urn:oasis:names:tc:SAML:2.0:assertion"><protocolVersion>application/vnd.ogf.nsi.cs.v2.provider+soap</protocolVersion><correlationId>urn:uuid:213c1379-6b96-4f73-a0dd-ebe80af96f09</correlationId><requesterNSA>urn:ogf:network:es.net:2013:nsa:nsi-aggr-west</requesterNSA><providerNSA>urn:ogf:network:manlan.internet2.edu:2013:nsa</providerNSA></ns6:nsiHeader></soap:Header><soap:Body><ns5:reserveResponse xmlns:ns2="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:ns3="http://www.w3.org/2001/04/xmlenc#" xmlns:ns4="http://www.w3.org/2000/09/xmldsig#" xmlns:ns5="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point"><connectionId>urn:uuid:a46f19fa-fd4d-4bc5-ad68-390604bcf6fa</connectionId></ns5:reserveResponse></soap:Body></soap:Envelope> -
2014-06-25 20:42:23,282 DEBUG application play-akka.actor.default-dispatcher-267 - Received ack from urn:ogf:network:manlan.internet2.edu:2013:nsa at https://oscars.manlan.internet2.edu:8500/ConnectionServiceProvider: NsiProviderMessage(NsiHeaders(urn:uuid:213c1379-6b96-4f73-a0dd-ebe80af96f09,urn:ogf:network:es.net:2013:nsa:nsi-aggr-west,urn:ogf:network:manlan.internet2.edu:2013:nsa,None,application/vnd.ogf.nsi.cs.v2.provider+soap,List(),List()),ReserveResponse(urn:uuid:a46f19fa-fd4d-4bc5-ad68-390604bcf6fa)) -
2014-06-25 20:42:23,283 DEBUG application application-akka.actor.default-dispatcher-243 - state change from CheckingReservationState to CheckingReservationState -
2014-06-25 20:42:23,316 DEBUG application application-akka.actor.default-dispatcher-243 - Scheduling Delete for execution after 86399966 milliseconds -
2014-06-25 20:42:29,441 DEBUG application play-akka.actor.default-dispatcher-267 - received SOAP message /nsi-v2/ConnectionServiceRequester from 140.182.45.16 with content-type Some(text/xml) <soap:Envelope xmlns:soap="http://schemas.xmlsoap.org/soap/envelope/"><soap:Header><ns7:nsiHeader xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns5="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns4="http://www.w3.org/2000/09/xmldsig#" xmlns:ns3="http://www.w3.org/2001/04/xmlenc#" xmlns:ns2="urn:oasis:names:tc:SAML:2.0:assertion"><protocolVersion>application/vdn.ogf.nsi.cs.v2.provider+soap</protocolVersion><correlationId>urn:uuid:213c1379-6b96-4f73-a0dd-ebe80af96f09</correlationId><requesterNSA>urn:ogf:network:es.net:2013:nsa:nsi-aggr-west</requesterNSA><providerNSA>urn:ogf:network:manlan.internet2.edu</providerNSA><replyTo>https://oscars.bldc.manlan.internet2.edu:8500//ConnectionService</replyTo></ns7:nsiHeader></soap:Header><soap:Body><ns5:reserveConfirmed xmlns:ns2="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:ns3="http://www.w3.org/2001/04/xmlenc#" xmlns:ns4="http://www.w3.org/2000/09/xmldsig#" xmlns:ns5="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point"><connectionId>urn:uuid:a46f19fa-fd4d-4bc5-ad68-390604bcf6fa</connectionId><globalReservationId>urn:uuid:2888ca60-e612-11e3-ac10-0800200c9998</globalReservationId><description>Test: Terminate after end time</description><criteria version="1"><schedule><startTime>2014-06-25T20:45:00.000-07:00</startTime><endTime>2014-06-25T20:50:00.000-07:00</endTime></schedule><serviceType>http://services.ogf.org/nsi/2013/12/descriptions/EVTS.A-GOLE</serviceType><ns8:p2ps><capacity>100</capacity><directionality>Bidirectional</directionality><symmetricPath>true</symmetricPath><sourceSTP>urn:ogf:network:manlan.internet2.edu:2013:es?vlan=1780</sourceSTP><destSTP>urn:ogf:network:manlan.internet2.edu:2013:netherlight?vlan=1780</destSTP></ns8:p2ps></criteria></ns5:reserveConfirmed></soap:Body></soap:Envelope> -
2014-06-25 20:42:29,445 DEBUG application play-akka.actor.default-dispatcher-266 - SOAP message parse result Success([#document: null]) -
2014-06-25 20:42:29,450 DEBUG application play-internal-execution-context-1 - Received (/nsi-v2/ConnectionServiceRequester): Success(NsiRequesterMessage(NsiHeaders(urn:uuid:213c1379-6b96-4f73-a0dd-ebe80af96f09,urn:ogf:network:es.net:2013:nsa:nsi-aggr-west,urn:ogf:network:manlan.internet2.edu,Some(https://oscars.bldc.manlan.internet2.edu:8500//ConnectionService),application/vdn.ogf.nsi.cs.v2.provider+soap,List(),List()),ReserveConfirmed(urn:uuid:a46f19fa-fd4d-4bc5-ad68-390604bcf6fa,org.ogf.schemas.nsi._2013._12.connection.types.ReservationConfirmCriteriaType@40d58b94[schedule=org.ogf.schemas.nsi._2013._12.connection.types.ScheduleType@425b9d83[startTime=2014-06-25T20:45:00.000-07:00, endTime=2014-06-25T20:50:00.000-07:00], serviceType=http://services.ogf.org/nsi/2013/12/descriptions/EVTS.A-GOLE, any={<{http://schemas.ogf.org/nsi/2013/12/services/point2point}p2ps[org.ogf.schemas.nsi._2013._12.services.point2point.P2PServiceBaseType@76e74b15[capacity=100, directionality=BIDIRECTIONAL, symmetricPath=true, sourceSTP=urn:ogf:network:manlan.internet2.edu:2013:es?vlan=1780, destSTP=urn:ogf:network:manlan.internet2.edu:2013:netherlight?vlan=1780, ero=<null>, parameter=<null>, any=<null>]]>}, version=1]))) -
2014-06-25 20:42:29,452 DEBUG application application-akka.actor.default-dispatcher-243 - state change from CheckingReservationState to CheckingReservationState -
2014-06-25 20:42:29,455 DEBUG application play-akka.actor.default-dispatcher-267 - Ack 140.182.45.16 with Success(<?xml version="1.0" encoding="UTF-8" standalone="no"?><soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/"><soapenv:Header><ns7:nsiHeader xmlns:ns2="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns3="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:ns4="http://www.w3.org/2001/04/xmlenc#" xmlns:ns5="http://www.w3.org/2000/09/xmldsig#" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point" xmlns:ns9="http://nordu.net/namespaces/2013/12/gnsbod"><protocolVersion>application/vnd.ogf.nsi.cs.v2.requester+soap</protocolVersion><correlationId>urn:uuid:213c1379-6b96-4f73-a0dd-ebe80af96f09</correlationId><requesterNSA>urn:ogf:network:es.net:2013:nsa:nsi-aggr-west</requesterNSA><providerNSA>urn:ogf:network:manlan.internet2.edu</providerNSA></ns7:nsiHeader></soapenv:Header><soapenv:Body><ns2:acknowledgment xmlns:ns2="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns3="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:ns4="http://www.w3.org/2001/04/xmlenc#" xmlns:ns5="http://www.w3.org/2000/09/xmldsig#" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point" xmlns:ns9="http://nordu.net/namespaces/2013/12/gnsbod"/></soapenv:Body></soapenv:Envelope>) -
2014-06-25 20:42:29,488 DEBUG application application-akka.actor.default-dispatcher-243 - Scheduling Delete for execution after 86399964 milliseconds -
2014-06-25 20:42:29,740 DEBUG application play-akka.actor.default-dispatcher-267 - received SOAP message /nsi-v2/ConnectionServiceRequester from 198.128.14.168 with content-type Some(text/xml) <soap:Envelope xmlns:soap="http://schemas.xmlsoap.org/soap/envelope/"><soap:Header><ns7:nsiHeader xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns5="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns4="http://www.w3.org/2000/09/xmldsig#" xmlns:ns3="http://www.w3.org/2001/04/xmlenc#" xmlns:ns2="urn:oasis:names:tc:SAML:2.0:assertion"><protocolVersion>application/vdn.ogf.nsi.cs.v2.provider+soap</protocolVersion><correlationId>urn:uuid:51de9878-41ac-481b-bc82-5691b99b19c1</correlationId><requesterNSA>urn:ogf:network:es.net:2013:nsa:nsi-aggr-west</requesterNSA><providerNSA>urn:ogf:network:nsa:es.net</providerNSA><replyTo>https://oscars.es.net:8500//ConnectionService</replyTo></ns7:nsiHeader></soap:Header><soap:Body><ns5:reserveConfirmed xmlns:ns2="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:ns3="http://www.w3.org/2001/04/xmlenc#" xmlns:ns4="http://www.w3.org/2000/09/xmldsig#" xmlns:ns5="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point"><connectionId>urn:uuid:c2944c2e-c464-4c76-805d-f0f57cb7981b</connectionId><globalReservationId>urn:uuid:2888ca60-e612-11e3-ac10-0800200c9998</globalReservationId><description>Test: Terminate after end time</description><criteria version="1"><schedule><startTime>2014-06-25T20:45:00.000-07:00</startTime><endTime>2014-06-25T20:50:00.000-07:00</endTime></schedule><serviceType>http://services.ogf.org/nsi/2013/12/descriptions/EVTS.A-GOLE</serviceType><ns8:p2ps><capacity>100</capacity><directionality>Bidirectional</directionality><symmetricPath>true</symmetricPath><sourceSTP>urn:ogf:network:es.net:2013:ps:sunn:1?vlan=1780</sourceSTP><destSTP>urn:ogf:network:es.net:2013:manlan:aofa:1?vlan=1780</destSTP></ns8:p2ps></criteria></ns5:reserveConfirmed></soap:Body></soap:Envelope> -
2014-06-25 20:42:29,744 DEBUG application play-akka.actor.default-dispatcher-267 - SOAP message parse result Success([#document: null]) -
2014-06-25 20:42:29,748 DEBUG application play-internal-execution-context-1 - Received (/nsi-v2/ConnectionServiceRequester): Success(NsiRequesterMessage(NsiHeaders(urn:uuid:51de9878-41ac-481b-bc82-5691b99b19c1,urn:ogf:network:es.net:2013:nsa:nsi-aggr-west,urn:ogf:network:nsa:es.net,Some(https://oscars.es.net:8500//ConnectionService),application/vdn.ogf.nsi.cs.v2.provider+soap,List(),List()),ReserveConfirmed(urn:uuid:c2944c2e-c464-4c76-805d-f0f57cb7981b,org.ogf.schemas.nsi._2013._12.connection.types.ReservationConfirmCriteriaType@2f715895[schedule=org.ogf.schemas.nsi._2013._12.connection.types.ScheduleType@7f719636[startTime=2014-06-25T20:45:00.000-07:00, endTime=2014-06-25T20:50:00.000-07:00], serviceType=http://services.ogf.org/nsi/2013/12/descriptions/EVTS.A-GOLE, any={<{http://schemas.ogf.org/nsi/2013/12/services/point2point}p2ps[org.ogf.schemas.nsi._2013._12.services.point2point.P2PServiceBaseType@109f6570[capacity=100, directionality=BIDIRECTIONAL, symmetricPath=true, sourceSTP=urn:ogf:network:es.net:2013:ps:sunn:1?vlan=1780, destSTP=urn:ogf:network:es.net:2013:manlan:aofa:1?vlan=1780, ero=<null>, parameter=<null>, any=<null>]]>}, version=1]))) -
2014-06-25 20:42:29,750 DEBUG application application-akka.actor.default-dispatcher-243 - state change from CheckingReservationState to HeldReservationState -
2014-06-25 20:42:29,753 DEBUG application play-akka.actor.default-dispatcher-267 - Ack 198.128.14.168 with Success(<?xml version="1.0" encoding="UTF-8" standalone="no"?><soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/"><soapenv:Header><ns7:nsiHeader xmlns:ns2="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns3="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:ns4="http://www.w3.org/2001/04/xmlenc#" xmlns:ns5="http://www.w3.org/2000/09/xmldsig#" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point" xmlns:ns9="http://nordu.net/namespaces/2013/12/gnsbod"><protocolVersion>application/vnd.ogf.nsi.cs.v2.requester+soap</protocolVersion><correlationId>urn:uuid:51de9878-41ac-481b-bc82-5691b99b19c1</correlationId><requesterNSA>urn:ogf:network:es.net:2013:nsa:nsi-aggr-west</requesterNSA><providerNSA>urn:ogf:network:nsa:es.net</providerNSA></ns7:nsiHeader></soapenv:Header><soapenv:Body><ns2:acknowledgment xmlns:ns2="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns3="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:ns4="http://www.w3.org/2001/04/xmlenc#" xmlns:ns5="http://www.w3.org/2000/09/xmldsig#" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point" xmlns:ns9="http://nordu.net/namespaces/2013/12/gnsbod"/></soapenv:Body></soapenv:Envelope>) -
2014-06-25 20:42:29,809 DEBUG application application-akka.actor.default-dispatcher-243 - Scheduling Delete for execution after 86399941 milliseconds -
2014-06-25 20:42:29,815 DEBUG application play-akka.actor.default-dispatcher-267 - Sending provider urn:ogf:network:es.net:2013:nsa:nsi-requester at https://nsi-aggr-west.es.net/requester/reply the SOAP message: Success(<?xml version="1.0" encoding="UTF-8" standalone="no"?><soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/"><soapenv:Header><ns7:nsiHeader xmlns:ns2="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns3="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:ns4="http://www.w3.org/2001/04/xmlenc#" xmlns:ns5="http://www.w3.org/2000/09/xmldsig#" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point" xmlns:ns9="http://nordu.net/namespaces/2013/12/gnsbod"><protocolVersion>application/vnd.ogf.nsi.cs.v2.provider+soap</protocolVersion><correlationId>urn:uuid:d0735d1a-6ee8-43ac-b467-7c1ac7233a2b</correlationId><requesterNSA>urn:ogf:network:es.net:2013:nsa:nsi-requester</requesterNSA><providerNSA>urn:ogf:network:es.net:2013:nsa:nsi-aggr-west</providerNSA></ns7:nsiHeader></soapenv:Header><soapenv:Body><ns2:reserveConfirmed xmlns:ns2="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns3="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:ns4="http://www.w3.org/2001/04/xmlenc#" xmlns:ns5="http://www.w3.org/2000/09/xmldsig#" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point" xmlns:ns9="http://nordu.net/namespaces/2013/12/gnsbod"><connectionId>494e60a6-db7f-4285-9e66-500289299731</connectionId><criteria version="1"><schedule><startTime>2014-06-25T20:45:00.000-07:00</startTime><endTime>2014-06-25T20:50:00.000-07:00</endTime></schedule><serviceType>http://services.ogf.org/nsi/2013/12/descriptions/EVTS.A-GOLE</serviceType><ns8:p2ps><capacity>100</capacity><directionality>Bidirectional</directionality><symmetricPath>true</symmetricPath><sourceSTP>urn:ogf:network:es.net:2013:ps:sunn:1?vlan=1780</sourceSTP><destSTP>urn:ogf:network:manlan.internet2.edu:2013:netherlight?vlan=1780</destSTP><parameter type="protection">UNPROTECTED</parameter></ns8:p2ps></criteria></ns2:reserveConfirmed></soapenv:Body></soapenv:Envelope>) -
2014-06-25 20:42:29,960 DEBUG application play-akka.actor.default-dispatcher-267 - Parsing SOAP ack (200) from urn:ogf:network:es.net:2013:nsa:nsi-requester at https://nsi-aggr-west.es.net/requester/reply: <soapenv:Envelope xmlns:xs="http://www.w3.org/2001/XMLSchema" xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance" xmlns:gns="http://nordu.net/namespaces/2013/12/gnsbod" xmlns:saml="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:type="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:head="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/">
<soapenv:Header>
<head:nsiHeader>
<protocolVersion>application/vnd.ogf.nsi.cs.v2.requester+soap</protocolVersion>
<correlationId>urn:uuid:d0735d1a-6ee8-43ac-b467-7c1ac7233a2b</correlationId>
<requesterNSA>urn:ogf:network:es.net:2013:nsa:nsi-requester</requesterNSA>
<providerNSA>urn:ogf:network:es.net:2013:nsa:nsi-aggr-west</providerNSA>
</head:nsiHeader>
</soapenv:Header>
<soapenv:Body>
<type:acknowledgment/>
</soapenv:Body>
</soapenv:Envelope> -
2014-06-25 20:42:29,965 DEBUG application play-akka.actor.default-dispatcher-267 - Received ack from urn:ogf:network:es.net:2013:nsa:nsi-requester at https://nsi-aggr-west.es.net/requester/reply: NsiRequesterMessage(NsiHeaders(urn:uuid:d0735d1a-6ee8-43ac-b467-7c1ac7233a2b,urn:ogf:network:es.net:2013:nsa:nsi-requester,urn:ogf:network:es.net:2013:nsa:nsi-aggr-west,None,application/vnd.ogf.nsi.cs.v2.requester+soap,List(),List()),GenericAck()) -
2014-06-25 20:42:29,966 DEBUG application play-akka.actor.default-dispatcher-267 - Replying ReserveConfirmed(494e60a6-db7f-4285-9e66-500289299731,org.ogf.schemas.nsi._2013._12.connection.types.ReservationConfirmCriteriaType@2d1b7caf[schedule=org.ogf.schemas.nsi._2013._12.connection.types.ScheduleType@222b993e[startTime=2014-06-25T20:45:00.000-07:00, endTime=2014-06-25T20:50:00.000-07:00], serviceType=http://services.ogf.org/nsi/2013/12/descriptions/EVTS.A-GOLE, any={<{http://schemas.ogf.org/nsi/2013/12/services/point2point}p2ps[org.ogf.schemas.nsi._2013._12.services.point2point.P2PServiceBaseType@2cd2ec3f[capacity=100, directionality=BIDIRECTIONAL, symmetricPath=true, sourceSTP=urn:ogf:network:es.net:2013:ps:sunn:1?vlan=1780, destSTP=urn:ogf:network:manlan.internet2.edu:2013:netherlight?vlan=1780, ero=<null>, parameter={org.ogf.schemas.nsi._2013._12.services.types.TypeValueType@692fae4a[value=UNPROTECTED, type=protection]}, any=<null>]]>}, version=1]) to https://nsi-aggr-west.es.net/requester/reply succeeded with NsiRequesterMessage(NsiHeaders(urn:uuid:d0735d1a-6ee8-43ac-b467-7c1ac7233a2b,urn:ogf:network:es.net:2013:nsa:nsi-requester,urn:ogf:network:es.net:2013:nsa:nsi-aggr-west,None,application/vnd.ogf.nsi.cs.v2.requester+soap,List(),List()),GenericAck()) -
2014-06-25 20:42:44,304 DEBUG application play-akka.actor.default-dispatcher-264 - received SOAP message /nsi-v2/ConnectionServiceProvider from 127.0.0.1 with content-type Some(text/xml) <soapenv:Envelope xmlns:xs="http://www.w3.org/2001/XMLSchema" xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance" xmlns:gns="http://nordu.net/namespaces/2013/12/gnsbod" xmlns:saml="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:type="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:head="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/">
<soapenv:Header>
<head:nsiHeader>
<protocolVersion>application/vnd.ogf.nsi.cs.v2.provider+soap</protocolVersion>
<correlationId>urn:uuid:dfbd2e1d-331e-4a75-9a09-f22c974a5564</correlationId>
<requesterNSA>urn:ogf:network:es.net:2013:nsa:nsi-requester</requesterNSA>
<providerNSA>urn:ogf:network:es.net:2013:nsa:nsi-aggr-west</providerNSA>
<replyTo>https://nsi-aggr-west.es.net/requester/reply</replyTo>
</head:nsiHeader>
</soapenv:Header>
<soapenv:Body>
<type:reserveCommit>
<connectionId>494e60a6-db7f-4285-9e66-500289299731</connectionId>
</type:reserveCommit>
</soapenv:Body>
</soapenv:Envelope> -
2014-06-25 20:42:44,308 DEBUG application play-akka.actor.default-dispatcher-264 - SOAP message parse result Success([#document: null]) -
2014-06-25 20:42:44,311 DEBUG application play-internal-execution-context-1 - Received (/nsi-v2/ConnectionServiceProvider): Success(NsiProviderMessage(NsiHeaders(urn:uuid:dfbd2e1d-331e-4a75-9a09-f22c974a5564,urn:ogf:network:es.net:2013:nsa:nsi-requester,urn:ogf:network:es.net:2013:nsa:nsi-aggr-west,Some(https://nsi-aggr-west.es.net/requester/reply),application/vnd.ogf.nsi.cs.v2.provider+soap,List(),List()),ReserveCommit(494e60a6-db7f-4285-9e66-500289299731))) -
2014-06-25 20:42:44,313 DEBUG application application-akka.actor.default-dispatcher-230 - state change from HeldReservationState to CommittingReservationState -
2014-06-25 20:42:44,399 DEBUG application application-akka.actor.default-dispatcher-230 - Scheduling Delete for execution after 86399914 milliseconds -
2014-06-25 20:42:44,402 DEBUG application play-akka.actor.default-dispatcher-264 - Ack 127.0.0.1 with Success(<?xml version="1.0" encoding="UTF-8" standalone="no"?><soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/"><soapenv:Header><ns7:nsiHeader xmlns:ns2="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns3="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:ns4="http://www.w3.org/2001/04/xmlenc#" xmlns:ns5="http://www.w3.org/2000/09/xmldsig#" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point" xmlns:ns9="http://nordu.net/namespaces/2013/12/gnsbod"><protocolVersion>application/vnd.ogf.nsi.cs.v2.provider+soap</protocolVersion><correlationId>urn:uuid:dfbd2e1d-331e-4a75-9a09-f22c974a5564</correlationId><requesterNSA>urn:ogf:network:es.net:2013:nsa:nsi-requester</requesterNSA><providerNSA>urn:ogf:network:es.net:2013:nsa:nsi-aggr-west</providerNSA></ns7:nsiHeader></soapenv:Header><soapenv:Body><ns2:acknowledgment xmlns:ns2="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns3="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:ns4="http://www.w3.org/2001/04/xmlenc#" xmlns:ns5="http://www.w3.org/2000/09/xmldsig#" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point" xmlns:ns9="http://nordu.net/namespaces/2013/12/gnsbod"/></soapenv:Body></soapenv:Envelope>) -
2014-06-25 20:42:44,406 DEBUG application application-akka.actor.default-dispatcher-243 - Sending provider urn:ogf:network:es.net:2013:nsa at https://oscars.es.net/ConnectionService the SOAP message: Success(<?xml version="1.0" encoding="UTF-8" standalone="no"?><soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/"><soapenv:Header><ns7:nsiHeader xmlns:ns2="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns3="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:ns4="http://www.w3.org/2001/04/xmlenc#" xmlns:ns5="http://www.w3.org/2000/09/xmldsig#" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point" xmlns:ns9="http://nordu.net/namespaces/2013/12/gnsbod"><protocolVersion>application/vnd.ogf.nsi.cs.v2.provider+soap</protocolVersion><correlationId>urn:uuid:bfa25869-77e1-4b79-ad7f-4fd5433707ae</correlationId><requesterNSA>urn:ogf:network:es.net:2013:nsa:nsi-aggr-west</requesterNSA><providerNSA>urn:ogf:network:es.net:2013:nsa</providerNSA><replyTo>https://nsi-aggr-west.es.net/nsi-v2/ConnectionServiceRequester</replyTo></ns7:nsiHeader></soapenv:Header><soapenv:Body><ns2:reserveCommit xmlns:ns2="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns3="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:ns4="http://www.w3.org/2001/04/xmlenc#" xmlns:ns5="http://www.w3.org/2000/09/xmldsig#" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point" xmlns:ns9="http://nordu.net/namespaces/2013/12/gnsbod"><connectionId>urn:uuid:c2944c2e-c464-4c76-805d-f0f57cb7981b</connectionId></ns2:reserveCommit></soapenv:Body></soapenv:Envelope>) -
2014-06-25 20:42:44,431 DEBUG application application-akka.actor.default-dispatcher-243 - Sending provider urn:ogf:network:manlan.internet2.edu:2013:nsa at https://oscars.manlan.internet2.edu:8500/ConnectionServiceProvider the SOAP message: Success(<?xml version="1.0" encoding="UTF-8" standalone="no"?><soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/"><soapenv:Header><ns7:nsiHeader xmlns:ns2="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns3="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:ns4="http://www.w3.org/2001/04/xmlenc#" xmlns:ns5="http://www.w3.org/2000/09/xmldsig#" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point" xmlns:ns9="http://nordu.net/namespaces/2013/12/gnsbod"><protocolVersion>application/vnd.ogf.nsi.cs.v2.provider+soap</protocolVersion><correlationId>urn:uuid:ec59b0de-2254-4619-8604-9ce7ad53be8a</correlationId><requesterNSA>urn:ogf:network:es.net:2013:nsa:nsi-aggr-west</requesterNSA><providerNSA>urn:ogf:network:manlan.internet2.edu:2013:nsa</providerNSA><replyTo>https://nsi-aggr-west.es.net/nsi-v2/ConnectionServiceRequester</replyTo></ns7:nsiHeader></soapenv:Header><soapenv:Body><ns2:reserveCommit xmlns:ns2="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns3="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:ns4="http://www.w3.org/2001/04/xmlenc#" xmlns:ns5="http://www.w3.org/2000/09/xmldsig#" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point" xmlns:ns9="http://nordu.net/namespaces/2013/12/gnsbod"><connectionId>urn:uuid:a46f19fa-fd4d-4bc5-ad68-390604bcf6fa</connectionId></ns2:reserveCommit></soapenv:Body></soapenv:Envelope>) -
2014-06-25 20:42:44,565 DEBUG application play-akka.actor.default-dispatcher-264 - Parsing SOAP ack (200) from urn:ogf:network:manlan.internet2.edu:2013:nsa at https://oscars.manlan.internet2.edu:8500/ConnectionServiceProvider: <soap:Envelope xmlns:soap="http://schemas.xmlsoap.org/soap/envelope/"><soap:Header><ns6:nsiHeader xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns5="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns4="http://www.w3.org/2000/09/xmldsig#" xmlns:ns3="http://www.w3.org/2001/04/xmlenc#" xmlns:ns2="urn:oasis:names:tc:SAML:2.0:assertion"><protocolVersion>application/vnd.ogf.nsi.cs.v2.provider+soap</protocolVersion><correlationId>urn:uuid:ec59b0de-2254-4619-8604-9ce7ad53be8a</correlationId><requesterNSA>urn:ogf:network:es.net:2013:nsa:nsi-aggr-west</requesterNSA><providerNSA>urn:ogf:network:manlan.internet2.edu:2013:nsa</providerNSA></ns6:nsiHeader></soap:Header><soap:Body><ns5:acknowledgment xmlns:ns2="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:ns3="http://www.w3.org/2001/04/xmlenc#" xmlns:ns4="http://www.w3.org/2000/09/xmldsig#" xmlns:ns5="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point"/></soap:Body></soap:Envelope> -
2014-06-25 20:42:44,570 DEBUG application play-akka.actor.default-dispatcher-264 - Received ack from urn:ogf:network:manlan.internet2.edu:2013:nsa at https://oscars.manlan.internet2.edu:8500/ConnectionServiceProvider: NsiProviderMessage(NsiHeaders(urn:uuid:ec59b0de-2254-4619-8604-9ce7ad53be8a,urn:ogf:network:es.net:2013:nsa:nsi-aggr-west,urn:ogf:network:manlan.internet2.edu:2013:nsa,None,application/vnd.ogf.nsi.cs.v2.provider+soap,List(),List()),GenericAck()) -
2014-06-25 20:42:44,571 DEBUG application application-akka.actor.default-dispatcher-243 - state change from CommittingReservationState to CommittingReservationState -
2014-06-25 20:42:44,628 DEBUG application application-akka.actor.default-dispatcher-243 - Scheduling Delete for execution after 86399943 milliseconds -
2014-06-25 20:42:44,697 DEBUG application play-akka.actor.default-dispatcher-264 - Parsing SOAP ack (200) from urn:ogf:network:es.net:2013:nsa at https://oscars.es.net/ConnectionService: <soap:Envelope xmlns:soap="http://schemas.xmlsoap.org/soap/envelope/"><soap:Header><ns6:nsiHeader xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns5="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns4="http://www.w3.org/2000/09/xmldsig#" xmlns:ns3="http://www.w3.org/2001/04/xmlenc#" xmlns:ns2="urn:oasis:names:tc:SAML:2.0:assertion"><protocolVersion>application/vnd.ogf.nsi.cs.v2.provider+soap</protocolVersion><correlationId>urn:uuid:bfa25869-77e1-4b79-ad7f-4fd5433707ae</correlationId><requesterNSA>urn:ogf:network:es.net:2013:nsa:nsi-aggr-west</requesterNSA><providerNSA>urn:ogf:network:es.net:2013:nsa</providerNSA></ns6:nsiHeader></soap:Header><soap:Body><ns5:acknowledgment xmlns:ns2="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:ns3="http://www.w3.org/2001/04/xmlenc#" xmlns:ns4="http://www.w3.org/2000/09/xmldsig#" xmlns:ns5="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point"/></soap:Body></soap:Envelope> -
2014-06-25 20:42:44,701 DEBUG application play-akka.actor.default-dispatcher-264 - Received ack from urn:ogf:network:es.net:2013:nsa at https://oscars.es.net/ConnectionService: NsiProviderMessage(NsiHeaders(urn:uuid:bfa25869-77e1-4b79-ad7f-4fd5433707ae,urn:ogf:network:es.net:2013:nsa:nsi-aggr-west,urn:ogf:network:es.net:2013:nsa,None,application/vnd.ogf.nsi.cs.v2.provider+soap,List(),List()),GenericAck()) -
2014-06-25 20:42:44,702 DEBUG application application-akka.actor.default-dispatcher-243 - state change from CommittingReservationState to CommittingReservationState -
2014-06-25 20:42:44,735 DEBUG application application-akka.actor.default-dispatcher-243 - Scheduling Delete for execution after 86399967 milliseconds -
2014-06-25 20:42:45,722 DEBUG application play-akka.actor.default-dispatcher-264 - received SOAP message /nsi-v2/ConnectionServiceRequester from 198.128.14.168 with content-type Some(text/xml) <soap:Envelope xmlns:soap="http://schemas.xmlsoap.org/soap/envelope/"><soap:Header><ns7:nsiHeader xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns5="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns4="http://www.w3.org/2000/09/xmldsig#" xmlns:ns3="http://www.w3.org/2001/04/xmlenc#" xmlns:ns2="urn:oasis:names:tc:SAML:2.0:assertion"><protocolVersion>application/vdn.ogf.nsi.cs.v2.provider+soap</protocolVersion><correlationId>urn:uuid:bfa25869-77e1-4b79-ad7f-4fd5433707ae</correlationId><requesterNSA>urn:ogf:network:es.net:2013:nsa:nsi-aggr-west</requesterNSA><providerNSA>urn:ogf:network:nsa:es.net</providerNSA><replyTo>https://oscars.es.net:8500//ConnectionService</replyTo></ns7:nsiHeader></soap:Header><soap:Body><ns5:reserveCommitConfirmed xmlns:ns2="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:ns3="http://www.w3.org/2001/04/xmlenc#" xmlns:ns4="http://www.w3.org/2000/09/xmldsig#" xmlns:ns5="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point"><connectionId>urn:uuid:c2944c2e-c464-4c76-805d-f0f57cb7981b</connectionId></ns5:reserveCommitConfirmed></soap:Body></soap:Envelope> -
2014-06-25 20:42:45,726 DEBUG application play-akka.actor.default-dispatcher-264 - SOAP message parse result Success([#document: null]) -
2014-06-25 20:42:45,727 DEBUG application play-internal-execution-context-1 - Received (/nsi-v2/ConnectionServiceRequester): Success(NsiRequesterMessage(NsiHeaders(urn:uuid:bfa25869-77e1-4b79-ad7f-4fd5433707ae,urn:ogf:network:es.net:2013:nsa:nsi-aggr-west,urn:ogf:network:nsa:es.net,Some(https://oscars.es.net:8500//ConnectionService),application/vdn.ogf.nsi.cs.v2.provider+soap,List(),List()),ReserveCommitConfirmed(urn:uuid:c2944c2e-c464-4c76-805d-f0f57cb7981b))) -
2014-06-25 20:42:45,729 DEBUG application application-akka.actor.default-dispatcher-243 - state change from CommittingReservationState to CommittingReservationState -
2014-06-25 20:42:45,732 DEBUG application play-akka.actor.default-dispatcher-268 - Ack 198.128.14.168 with Success(<?xml version="1.0" encoding="UTF-8" standalone="no"?><soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/"><soapenv:Header><ns7:nsiHeader xmlns:ns2="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns3="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:ns4="http://www.w3.org/2001/04/xmlenc#" xmlns:ns5="http://www.w3.org/2000/09/xmldsig#" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point" xmlns:ns9="http://nordu.net/namespaces/2013/12/gnsbod"><protocolVersion>application/vnd.ogf.nsi.cs.v2.requester+soap</protocolVersion><correlationId>urn:uuid:bfa25869-77e1-4b79-ad7f-4fd5433707ae</correlationId><requesterNSA>urn:ogf:network:es.net:2013:nsa:nsi-aggr-west</requesterNSA><providerNSA>urn:ogf:network:nsa:es.net</providerNSA></ns7:nsiHeader></soapenv:Header><soapenv:Body><ns2:acknowledgment xmlns:ns2="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns3="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:ns4="http://www.w3.org/2001/04/xmlenc#" xmlns:ns5="http://www.w3.org/2000/09/xmldsig#" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point" xmlns:ns9="http://nordu.net/namespaces/2013/12/gnsbod"/></soapenv:Body></soapenv:Envelope>) -
2014-06-25 20:42:45,749 DEBUG application application-akka.actor.default-dispatcher-243 - Scheduling Delete for execution after 86399980 milliseconds -
2014-06-25 20:42:46,310 DEBUG application play-akka.actor.default-dispatcher-264 - received SOAP message /nsi-v2/ConnectionServiceRequester from 140.182.45.16 with content-type Some(text/xml) <soap:Envelope xmlns:soap="http://schemas.xmlsoap.org/soap/envelope/"><soap:Header><ns7:nsiHeader xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns5="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns4="http://www.w3.org/2000/09/xmldsig#" xmlns:ns3="http://www.w3.org/2001/04/xmlenc#" xmlns:ns2="urn:oasis:names:tc:SAML:2.0:assertion"><protocolVersion>application/vdn.ogf.nsi.cs.v2.provider+soap</protocolVersion><correlationId>urn:uuid:ec59b0de-2254-4619-8604-9ce7ad53be8a</correlationId><requesterNSA>urn:ogf:network:es.net:2013:nsa:nsi-aggr-west</requesterNSA><providerNSA>urn:ogf:network:manlan.internet2.edu</providerNSA><replyTo>https://oscars.bldc.manlan.internet2.edu:8500//ConnectionService</replyTo></ns7:nsiHeader></soap:Header><soap:Body><ns5:reserveCommitConfirmed xmlns:ns2="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:ns3="http://www.w3.org/2001/04/xmlenc#" xmlns:ns4="http://www.w3.org/2000/09/xmldsig#" xmlns:ns5="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point"><connectionId>urn:uuid:a46f19fa-fd4d-4bc5-ad68-390604bcf6fa</connectionId></ns5:reserveCommitConfirmed></soap:Body></soap:Envelope> -
2014-06-25 20:42:46,314 DEBUG application play-akka.actor.default-dispatcher-264 - SOAP message parse result Success([#document: null]) -
2014-06-25 20:42:46,316 DEBUG application play-internal-execution-context-1 - Received (/nsi-v2/ConnectionServiceRequester): Success(NsiRequesterMessage(NsiHeaders(urn:uuid:ec59b0de-2254-4619-8604-9ce7ad53be8a,urn:ogf:network:es.net:2013:nsa:nsi-aggr-west,urn:ogf:network:manlan.internet2.edu,Some(https://oscars.bldc.manlan.internet2.edu:8500//ConnectionService),application/vdn.ogf.nsi.cs.v2.provider+soap,List(),List()),ReserveCommitConfirmed(urn:uuid:a46f19fa-fd4d-4bc5-ad68-390604bcf6fa))) -
2014-06-25 20:42:46,318 DEBUG application application-akka.actor.default-dispatcher-243 - state change from CommittingReservationState to ReservedReservationState -
2014-06-25 20:42:46,321 DEBUG application play-akka.actor.default-dispatcher-264 - Ack 140.182.45.16 with Success(<?xml version="1.0" encoding="UTF-8" standalone="no"?><soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/"><soapenv:Header><ns7:nsiHeader xmlns:ns2="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns3="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:ns4="http://www.w3.org/2001/04/xmlenc#" xmlns:ns5="http://www.w3.org/2000/09/xmldsig#" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point" xmlns:ns9="http://nordu.net/namespaces/2013/12/gnsbod"><protocolVersion>application/vnd.ogf.nsi.cs.v2.requester+soap</protocolVersion><correlationId>urn:uuid:ec59b0de-2254-4619-8604-9ce7ad53be8a</correlationId><requesterNSA>urn:ogf:network:es.net:2013:nsa:nsi-aggr-west</requesterNSA><providerNSA>urn:ogf:network:manlan.internet2.edu</providerNSA></ns7:nsiHeader></soapenv:Header><soapenv:Body><ns2:acknowledgment xmlns:ns2="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns3="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:ns4="http://www.w3.org/2001/04/xmlenc#" xmlns:ns5="http://www.w3.org/2000/09/xmldsig#" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point" xmlns:ns9="http://nordu.net/namespaces/2013/12/gnsbod"/></soapenv:Body></soapenv:Envelope>) -
2014-06-25 20:42:46,371 DEBUG application application-akka.actor.default-dispatcher-243 - Scheduling Command(2014-06-26T03:50:00.000Z,PassedEndTime(urn:uuid:d1c4de23-9f52-43be-a7c4-97c631ec37b7,494e60a6-db7f-4285-9e66-500289299731,2014-06-25T20:50:00.000-07:00)) for execution after 433629 milliseconds -
2014-06-25 20:42:46,376 DEBUG application play-akka.actor.default-dispatcher-264 - Sending provider urn:ogf:network:es.net:2013:nsa:nsi-requester at https://nsi-aggr-west.es.net/requester/reply the SOAP message: Success(<?xml version="1.0" encoding="UTF-8" standalone="no"?><soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/"><soapenv:Header><ns7:nsiHeader xmlns:ns2="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns3="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:ns4="http://www.w3.org/2001/04/xmlenc#" xmlns:ns5="http://www.w3.org/2000/09/xmldsig#" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point" xmlns:ns9="http://nordu.net/namespaces/2013/12/gnsbod"><protocolVersion>application/vnd.ogf.nsi.cs.v2.provider+soap</protocolVersion><correlationId>urn:uuid:dfbd2e1d-331e-4a75-9a09-f22c974a5564</correlationId><requesterNSA>urn:ogf:network:es.net:2013:nsa:nsi-requester</requesterNSA><providerNSA>urn:ogf:network:es.net:2013:nsa:nsi-aggr-west</providerNSA></ns7:nsiHeader></soapenv:Header><soapenv:Body><ns2:reserveCommitConfirmed xmlns:ns2="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns3="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:ns4="http://www.w3.org/2001/04/xmlenc#" xmlns:ns5="http://www.w3.org/2000/09/xmldsig#" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point" xmlns:ns9="http://nordu.net/namespaces/2013/12/gnsbod"><connectionId>494e60a6-db7f-4285-9e66-500289299731</connectionId></ns2:reserveCommitConfirmed></soapenv:Body></soapenv:Envelope>) -
2014-06-25 20:42:46,512 DEBUG application play-akka.actor.default-dispatcher-264 - Parsing SOAP ack (200) from urn:ogf:network:es.net:2013:nsa:nsi-requester at https://nsi-aggr-west.es.net/requester/reply: <soapenv:Envelope xmlns:xs="http://www.w3.org/2001/XMLSchema" xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance" xmlns:gns="http://nordu.net/namespaces/2013/12/gnsbod" xmlns:saml="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:type="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:head="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/">
<soapenv:Header>
<head:nsiHeader>
<protocolVersion>application/vnd.ogf.nsi.cs.v2.requester+soap</protocolVersion>
<correlationId>urn:uuid:dfbd2e1d-331e-4a75-9a09-f22c974a5564</correlationId>
<requesterNSA>urn:ogf:network:es.net:2013:nsa:nsi-requester</requesterNSA>
<providerNSA>urn:ogf:network:es.net:2013:nsa:nsi-aggr-west</providerNSA>
</head:nsiHeader>
</soapenv:Header>
<soapenv:Body>
<type:acknowledgment/>
</soapenv:Body>
</soapenv:Envelope> -
2014-06-25 20:42:46,516 DEBUG application play-akka.actor.default-dispatcher-264 - Received ack from urn:ogf:network:es.net:2013:nsa:nsi-requester at https://nsi-aggr-west.es.net/requester/reply: NsiRequesterMessage(NsiHeaders(urn:uuid:dfbd2e1d-331e-4a75-9a09-f22c974a5564,urn:ogf:network:es.net:2013:nsa:nsi-requester,urn:ogf:network:es.net:2013:nsa:nsi-aggr-west,None,application/vnd.ogf.nsi.cs.v2.requester+soap,List(),List()),GenericAck()) -
2014-06-25 20:42:46,516 DEBUG application play-akka.actor.default-dispatcher-264 - Replying ReserveCommitConfirmed(494e60a6-db7f-4285-9e66-500289299731) to https://nsi-aggr-west.es.net/requester/reply succeeded with NsiRequesterMessage(NsiHeaders(urn:uuid:dfbd2e1d-331e-4a75-9a09-f22c974a5564,urn:ogf:network:es.net:2013:nsa:nsi-requester,urn:ogf:network:es.net:2013:nsa:nsi-aggr-west,None,application/vnd.ogf.nsi.cs.v2.requester+soap,List(),List()),GenericAck()) -
2014-06-25 20:42:56,314 DEBUG application play-akka.actor.default-dispatcher-264 - received SOAP message /nsi-v2/ConnectionServiceProvider from 127.0.0.1 with content-type Some(text/xml) <soapenv:Envelope xmlns:xs="http://www.w3.org/2001/XMLSchema" xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance" xmlns:gns="http://nordu.net/namespaces/2013/12/gnsbod" xmlns:saml="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:type="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:head="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/">
<soapenv:Header>
<head:nsiHeader>
<protocolVersion>application/vnd.ogf.nsi.cs.v2.provider+soap</protocolVersion>
<correlationId>urn:uuid:02ccdcef-19a1-468c-afb4-331b9cc026e6</correlationId>
<requesterNSA>urn:ogf:network:es.net:2013:nsa:nsi-requester</requesterNSA>
<providerNSA>urn:ogf:network:es.net:2013:nsa:nsi-aggr-west</providerNSA>
<replyTo>https://nsi-aggr-west.es.net/requester/reply</replyTo>
</head:nsiHeader>
</soapenv:Header>
<soapenv:Body>
<type:provision>
<connectionId>494e60a6-db7f-4285-9e66-500289299731</connectionId>
</type:provision>
</soapenv:Body>
</soapenv:Envelope> -
2014-06-25 20:42:56,318 DEBUG application play-akka.actor.default-dispatcher-264 - SOAP message parse result Success([#document: null]) -
2014-06-25 20:42:56,320 DEBUG application play-internal-execution-context-1 - Received (/nsi-v2/ConnectionServiceProvider): Success(NsiProviderMessage(NsiHeaders(urn:uuid:02ccdcef-19a1-468c-afb4-331b9cc026e6,urn:ogf:network:es.net:2013:nsa:nsi-requester,urn:ogf:network:es.net:2013:nsa:nsi-aggr-west,Some(https://nsi-aggr-west.es.net/requester/reply),application/vnd.ogf.nsi.cs.v2.provider+soap,List(),List()),Provision(494e60a6-db7f-4285-9e66-500289299731))) -
2014-06-25 20:42:56,338 DEBUG application application-akka.actor.default-dispatcher-243 - state change from RELEASED to PROVISIONING -
2014-06-25 20:42:56,411 DEBUG application application-akka.actor.default-dispatcher-243 - Scheduling Command(2014-06-26T03:50:00.000Z,PassedEndTime(urn:uuid:fbd9e804-f09c-44f8-9b82-f09684bc3762,494e60a6-db7f-4285-9e66-500289299731,2014-06-25T20:50:00.000-07:00)) for execution after 423589 milliseconds -
2014-06-25 20:42:56,416 DEBUG application play-akka.actor.default-dispatcher-266 - Ack 127.0.0.1 with Success(<?xml version="1.0" encoding="UTF-8" standalone="no"?><soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/"><soapenv:Header><ns7:nsiHeader xmlns:ns2="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns3="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:ns4="http://www.w3.org/2001/04/xmlenc#" xmlns:ns5="http://www.w3.org/2000/09/xmldsig#" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point" xmlns:ns9="http://nordu.net/namespaces/2013/12/gnsbod"><protocolVersion>application/vnd.ogf.nsi.cs.v2.provider+soap</protocolVersion><correlationId>urn:uuid:02ccdcef-19a1-468c-afb4-331b9cc026e6</correlationId><requesterNSA>urn:ogf:network:es.net:2013:nsa:nsi-requester</requesterNSA><providerNSA>urn:ogf:network:es.net:2013:nsa:nsi-aggr-west</providerNSA></ns7:nsiHeader></soapenv:Header><soapenv:Body><ns2:acknowledgment xmlns:ns2="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns3="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:ns4="http://www.w3.org/2001/04/xmlenc#" xmlns:ns5="http://www.w3.org/2000/09/xmldsig#" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point" xmlns:ns9="http://nordu.net/namespaces/2013/12/gnsbod"/></soapenv:Body></soapenv:Envelope>) -
2014-06-25 20:42:56,417 DEBUG application application-akka.actor.default-dispatcher-230 - Sending provider urn:ogf:network:es.net:2013:nsa at https://oscars.es.net/ConnectionService the SOAP message: Success(<?xml version="1.0" encoding="UTF-8" standalone="no"?><soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/"><soapenv:Header><ns7:nsiHeader xmlns:ns2="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns3="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:ns4="http://www.w3.org/2001/04/xmlenc#" xmlns:ns5="http://www.w3.org/2000/09/xmldsig#" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point" xmlns:ns9="http://nordu.net/namespaces/2013/12/gnsbod"><protocolVersion>application/vnd.ogf.nsi.cs.v2.provider+soap</protocolVersion><correlationId>urn:uuid:304b9ad0-60b7-4a2a-9c34-0f718a89721a</correlationId><requesterNSA>urn:ogf:network:es.net:2013:nsa:nsi-aggr-west</requesterNSA><providerNSA>urn:ogf:network:es.net:2013:nsa</providerNSA><replyTo>https://nsi-aggr-west.es.net/nsi-v2/ConnectionServiceRequester</replyTo></ns7:nsiHeader></soapenv:Header><soapenv:Body><ns2:provision xmlns:ns2="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns3="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:ns4="http://www.w3.org/2001/04/xmlenc#" xmlns:ns5="http://www.w3.org/2000/09/xmldsig#" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point" xmlns:ns9="http://nordu.net/namespaces/2013/12/gnsbod"><connectionId>urn:uuid:c2944c2e-c464-4c76-805d-f0f57cb7981b</connectionId></ns2:provision></soapenv:Body></soapenv:Envelope>) -
2014-06-25 20:42:56,442 DEBUG application application-akka.actor.default-dispatcher-230 - Sending provider urn:ogf:network:manlan.internet2.edu:2013:nsa at https://oscars.manlan.internet2.edu:8500/ConnectionServiceProvider the SOAP message: Success(<?xml version="1.0" encoding="UTF-8" standalone="no"?><soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/"><soapenv:Header><ns7:nsiHeader xmlns:ns2="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns3="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:ns4="http://www.w3.org/2001/04/xmlenc#" xmlns:ns5="http://www.w3.org/2000/09/xmldsig#" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point" xmlns:ns9="http://nordu.net/namespaces/2013/12/gnsbod"><protocolVersion>application/vnd.ogf.nsi.cs.v2.provider+soap</protocolVersion><correlationId>urn:uuid:2d28e4b9-103d-446f-bc64-a0dd6f2d140d</correlationId><requesterNSA>urn:ogf:network:es.net:2013:nsa:nsi-aggr-west</requesterNSA><providerNSA>urn:ogf:network:manlan.internet2.edu:2013:nsa</providerNSA><replyTo>https://nsi-aggr-west.es.net/nsi-v2/ConnectionServiceRequester</replyTo></ns7:nsiHeader></soapenv:Header><soapenv:Body><ns2:provision xmlns:ns2="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns3="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:ns4="http://www.w3.org/2001/04/xmlenc#" xmlns:ns5="http://www.w3.org/2000/09/xmldsig#" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point" xmlns:ns9="http://nordu.net/namespaces/2013/12/gnsbod"><connectionId>urn:uuid:a46f19fa-fd4d-4bc5-ad68-390604bcf6fa</connectionId></ns2:provision></soapenv:Body></soapenv:Envelope>) -
2014-06-25 20:42:56,570 DEBUG application play-akka.actor.default-dispatcher-266 - Parsing SOAP ack (200) from urn:ogf:network:manlan.internet2.edu:2013:nsa at https://oscars.manlan.internet2.edu:8500/ConnectionServiceProvider: <soap:Envelope xmlns:soap="http://schemas.xmlsoap.org/soap/envelope/"><soap:Header><ns6:nsiHeader xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns5="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns4="http://www.w3.org/2000/09/xmldsig#" xmlns:ns3="http://www.w3.org/2001/04/xmlenc#" xmlns:ns2="urn:oasis:names:tc:SAML:2.0:assertion"><protocolVersion>application/vnd.ogf.nsi.cs.v2.provider+soap</protocolVersion><correlationId>urn:uuid:2d28e4b9-103d-446f-bc64-a0dd6f2d140d</correlationId><requesterNSA>urn:ogf:network:es.net:2013:nsa:nsi-aggr-west</requesterNSA><providerNSA>urn:ogf:network:manlan.internet2.edu:2013:nsa</providerNSA></ns6:nsiHeader></soap:Header><soap:Body><ns5:acknowledgment xmlns:ns2="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:ns3="http://www.w3.org/2001/04/xmlenc#" xmlns:ns4="http://www.w3.org/2000/09/xmldsig#" xmlns:ns5="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point"/></soap:Body></soap:Envelope> -
2014-06-25 20:42:56,575 DEBUG application play-akka.actor.default-dispatcher-266 - Received ack from urn:ogf:network:manlan.internet2.edu:2013:nsa at https://oscars.manlan.internet2.edu:8500/ConnectionServiceProvider: NsiProviderMessage(NsiHeaders(urn:uuid:2d28e4b9-103d-446f-bc64-a0dd6f2d140d,urn:ogf:network:es.net:2013:nsa:nsi-aggr-west,urn:ogf:network:manlan.internet2.edu:2013:nsa,None,application/vnd.ogf.nsi.cs.v2.provider+soap,List(),List()),GenericAck()) -
2014-06-25 20:42:56,575 DEBUG application application-akka.actor.default-dispatcher-230 - state change from PROVISIONING to PROVISIONING -
2014-06-25 20:42:56,611 DEBUG application application-akka.actor.default-dispatcher-230 - Scheduling Command(2014-06-26T03:50:00.000Z,PassedEndTime(urn:uuid:17c8f9f6-b0d9-480b-b839-95c0c48b662a,494e60a6-db7f-4285-9e66-500289299731,2014-06-25T20:50:00.000-07:00)) for execution after 423390 milliseconds -
2014-06-25 20:42:56,750 DEBUG application play-akka.actor.default-dispatcher-266 - Parsing SOAP ack (200) from urn:ogf:network:es.net:2013:nsa at https://oscars.es.net/ConnectionService: <soap:Envelope xmlns:soap="http://schemas.xmlsoap.org/soap/envelope/"><soap:Header><ns6:nsiHeader xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns5="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns4="http://www.w3.org/2000/09/xmldsig#" xmlns:ns3="http://www.w3.org/2001/04/xmlenc#" xmlns:ns2="urn:oasis:names:tc:SAML:2.0:assertion"><protocolVersion>application/vnd.ogf.nsi.cs.v2.provider+soap</protocolVersion><correlationId>urn:uuid:304b9ad0-60b7-4a2a-9c34-0f718a89721a</correlationId><requesterNSA>urn:ogf:network:es.net:2013:nsa:nsi-aggr-west</requesterNSA><providerNSA>urn:ogf:network:es.net:2013:nsa</providerNSA></ns6:nsiHeader></soap:Header><soap:Body><ns5:acknowledgment xmlns:ns2="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:ns3="http://www.w3.org/2001/04/xmlenc#" xmlns:ns4="http://www.w3.org/2000/09/xmldsig#" xmlns:ns5="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point"/></soap:Body></soap:Envelope> -
2014-06-25 20:42:56,754 DEBUG application play-akka.actor.default-dispatcher-266 - Received ack from urn:ogf:network:es.net:2013:nsa at https://oscars.es.net/ConnectionService: NsiProviderMessage(NsiHeaders(urn:uuid:304b9ad0-60b7-4a2a-9c34-0f718a89721a,urn:ogf:network:es.net:2013:nsa:nsi-aggr-west,urn:ogf:network:es.net:2013:nsa,None,application/vnd.ogf.nsi.cs.v2.provider+soap,List(),List()),GenericAck()) -
2014-06-25 20:42:56,755 DEBUG application application-akka.actor.default-dispatcher-230 - state change from PROVISIONING to PROVISIONING -
2014-06-25 20:42:56,787 DEBUG application application-akka.actor.default-dispatcher-230 - Scheduling Command(2014-06-26T03:50:00.000Z,PassedEndTime(urn:uuid:55e8eccd-3c38-4e01-a04d-3010f810be8e,494e60a6-db7f-4285-9e66-500289299731,2014-06-25T20:50:00.000-07:00)) for execution after 423213 milliseconds -
2014-06-25 20:43:00,318 DEBUG application play-akka.actor.default-dispatcher-266 - received SOAP message /nsi-v2/ConnectionServiceRequester from 140.182.45.16 with content-type Some(text/xml) <soap:Envelope xmlns:soap="http://schemas.xmlsoap.org/soap/envelope/"><soap:Header><ns7:nsiHeader xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns5="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns4="http://www.w3.org/2000/09/xmldsig#" xmlns:ns3="http://www.w3.org/2001/04/xmlenc#" xmlns:ns2="urn:oasis:names:tc:SAML:2.0:assertion"><protocolVersion>application/vdn.ogf.nsi.cs.v2.provider+soap</protocolVersion><correlationId>urn:uuid:2d28e4b9-103d-446f-bc64-a0dd6f2d140d</correlationId><requesterNSA>urn:ogf:network:es.net:2013:nsa:nsi-aggr-west</requesterNSA><providerNSA>urn:ogf:network:manlan.internet2.edu</providerNSA><replyTo>https://oscars.bldc.manlan.internet2.edu:8500//ConnectionService</replyTo></ns7:nsiHeader></soap:Header><soap:Body><ns5:provisionConfirmed xmlns:ns2="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:ns3="http://www.w3.org/2001/04/xmlenc#" xmlns:ns4="http://www.w3.org/2000/09/xmldsig#" xmlns:ns5="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point"><connectionId>urn:uuid:a46f19fa-fd4d-4bc5-ad68-390604bcf6fa</connectionId></ns5:provisionConfirmed></soap:Body></soap:Envelope> -
2014-06-25 20:43:00,321 DEBUG application play-akka.actor.default-dispatcher-266 - SOAP message parse result Success([#document: null]) -
2014-06-25 20:43:00,324 DEBUG application play-internal-execution-context-1 - Received (/nsi-v2/ConnectionServiceRequester): Success(NsiRequesterMessage(NsiHeaders(urn:uuid:2d28e4b9-103d-446f-bc64-a0dd6f2d140d,urn:ogf:network:es.net:2013:nsa:nsi-aggr-west,urn:ogf:network:manlan.internet2.edu,Some(https://oscars.bldc.manlan.internet2.edu:8500//ConnectionService),application/vdn.ogf.nsi.cs.v2.provider+soap,List(),List()),ProvisionConfirmed(urn:uuid:a46f19fa-fd4d-4bc5-ad68-390604bcf6fa))) -
2014-06-25 20:43:00,326 DEBUG application application-akka.actor.default-dispatcher-230 - state change from PROVISIONING to PROVISIONING -
2014-06-25 20:43:00,330 DEBUG application play-akka.actor.default-dispatcher-264 - Ack 140.182.45.16 with Success(<?xml version="1.0" encoding="UTF-8" standalone="no"?><soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/"><soapenv:Header><ns7:nsiHeader xmlns:ns2="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns3="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:ns4="http://www.w3.org/2001/04/xmlenc#" xmlns:ns5="http://www.w3.org/2000/09/xmldsig#" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point" xmlns:ns9="http://nordu.net/namespaces/2013/12/gnsbod"><protocolVersion>application/vnd.ogf.nsi.cs.v2.requester+soap</protocolVersion><correlationId>urn:uuid:2d28e4b9-103d-446f-bc64-a0dd6f2d140d</correlationId><requesterNSA>urn:ogf:network:es.net:2013:nsa:nsi-aggr-west</requesterNSA><providerNSA>urn:ogf:network:manlan.internet2.edu</providerNSA></ns7:nsiHeader></soapenv:Header><soapenv:Body><ns2:acknowledgment xmlns:ns2="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns3="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:ns4="http://www.w3.org/2001/04/xmlenc#" xmlns:ns5="http://www.w3.org/2000/09/xmldsig#" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point" xmlns:ns9="http://nordu.net/namespaces/2013/12/gnsbod"/></soapenv:Body></soapenv:Envelope>) -
2014-06-25 20:43:00,361 DEBUG application application-akka.actor.default-dispatcher-230 - Scheduling Command(2014-06-26T03:50:00.000Z,PassedEndTime(urn:uuid:e0e4815e-785a-4009-90f4-d1640e799076,494e60a6-db7f-4285-9e66-500289299731,2014-06-25T20:50:00.000-07:00)) for execution after 419639 milliseconds -
2014-06-25 20:43:00,736 DEBUG application play-akka.actor.default-dispatcher-266 - received SOAP message /nsi-v2/ConnectionServiceRequester from 198.128.14.168 with content-type Some(text/xml) <soap:Envelope xmlns:soap="http://schemas.xmlsoap.org/soap/envelope/"><soap:Header><ns7:nsiHeader xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns5="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns4="http://www.w3.org/2000/09/xmldsig#" xmlns:ns3="http://www.w3.org/2001/04/xmlenc#" xmlns:ns2="urn:oasis:names:tc:SAML:2.0:assertion"><protocolVersion>application/vdn.ogf.nsi.cs.v2.provider+soap</protocolVersion><correlationId>urn:uuid:304b9ad0-60b7-4a2a-9c34-0f718a89721a</correlationId><requesterNSA>urn:ogf:network:es.net:2013:nsa:nsi-aggr-west</requesterNSA><providerNSA>urn:ogf:network:nsa:es.net</providerNSA><replyTo>https://oscars.es.net:8500//ConnectionService</replyTo></ns7:nsiHeader></soap:Header><soap:Body><ns5:provisionConfirmed xmlns:ns2="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:ns3="http://www.w3.org/2001/04/xmlenc#" xmlns:ns4="http://www.w3.org/2000/09/xmldsig#" xmlns:ns5="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point"><connectionId>urn:uuid:c2944c2e-c464-4c76-805d-f0f57cb7981b</connectionId></ns5:provisionConfirmed></soap:Body></soap:Envelope> -
2014-06-25 20:43:00,739 DEBUG application play-akka.actor.default-dispatcher-266 - SOAP message parse result Success([#document: null]) -
2014-06-25 20:43:00,741 DEBUG application play-internal-execution-context-1 - Received (/nsi-v2/ConnectionServiceRequester): Success(NsiRequesterMessage(NsiHeaders(urn:uuid:304b9ad0-60b7-4a2a-9c34-0f718a89721a,urn:ogf:network:es.net:2013:nsa:nsi-aggr-west,urn:ogf:network:nsa:es.net,Some(https://oscars.es.net:8500//ConnectionService),application/vdn.ogf.nsi.cs.v2.provider+soap,List(),List()),ProvisionConfirmed(urn:uuid:c2944c2e-c464-4c76-805d-f0f57cb7981b))) -
2014-06-25 20:43:00,743 DEBUG application application-akka.actor.default-dispatcher-230 - state change from PROVISIONING to PROVISIONED -
2014-06-25 20:43:00,746 DEBUG application play-akka.actor.default-dispatcher-269 - Ack 198.128.14.168 with Success(<?xml version="1.0" encoding="UTF-8" standalone="no"?><soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/"><soapenv:Header><ns7:nsiHeader xmlns:ns2="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns3="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:ns4="http://www.w3.org/2001/04/xmlenc#" xmlns:ns5="http://www.w3.org/2000/09/xmldsig#" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point" xmlns:ns9="http://nordu.net/namespaces/2013/12/gnsbod"><protocolVersion>application/vnd.ogf.nsi.cs.v2.requester+soap</protocolVersion><correlationId>urn:uuid:304b9ad0-60b7-4a2a-9c34-0f718a89721a</correlationId><requesterNSA>urn:ogf:network:es.net:2013:nsa:nsi-aggr-west</requesterNSA><providerNSA>urn:ogf:network:nsa:es.net</providerNSA></ns7:nsiHeader></soapenv:Header><soapenv:Body><ns2:acknowledgment xmlns:ns2="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns3="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:ns4="http://www.w3.org/2001/04/xmlenc#" xmlns:ns5="http://www.w3.org/2000/09/xmldsig#" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point" xmlns:ns9="http://nordu.net/namespaces/2013/12/gnsbod"/></soapenv:Body></soapenv:Envelope>) -
2014-06-25 20:43:00,846 DEBUG application application-akka.actor.default-dispatcher-230 - Scheduling Command(2014-06-26T03:50:00.000Z,PassedEndTime(urn:uuid:2ee632ad-b3f7-40d3-80e8-8d6d99b0a4ac,494e60a6-db7f-4285-9e66-500289299731,2014-06-25T20:50:00.000-07:00)) for execution after 419154 milliseconds -
2014-06-25 20:43:00,851 DEBUG application play-akka.actor.default-dispatcher-269 - Sending provider urn:ogf:network:es.net:2013:nsa:nsi-requester at https://nsi-aggr-west.es.net/requester/reply the SOAP message: Success(<?xml version="1.0" encoding="UTF-8" standalone="no"?><soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/"><soapenv:Header><ns7:nsiHeader xmlns:ns2="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns3="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:ns4="http://www.w3.org/2001/04/xmlenc#" xmlns:ns5="http://www.w3.org/2000/09/xmldsig#" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point" xmlns:ns9="http://nordu.net/namespaces/2013/12/gnsbod"><protocolVersion>application/vnd.ogf.nsi.cs.v2.provider+soap</protocolVersion><correlationId>urn:uuid:02ccdcef-19a1-468c-afb4-331b9cc026e6</correlationId><requesterNSA>urn:ogf:network:es.net:2013:nsa:nsi-requester</requesterNSA><providerNSA>urn:ogf:network:es.net:2013:nsa:nsi-aggr-west</providerNSA></ns7:nsiHeader></soapenv:Header><soapenv:Body><ns2:provisionConfirmed xmlns:ns2="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns3="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:ns4="http://www.w3.org/2001/04/xmlenc#" xmlns:ns5="http://www.w3.org/2000/09/xmldsig#" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point" xmlns:ns9="http://nordu.net/namespaces/2013/12/gnsbod"><connectionId>494e60a6-db7f-4285-9e66-500289299731</connectionId></ns2:provisionConfirmed></soapenv:Body></soapenv:Envelope>) -
2014-06-25 20:43:00,995 DEBUG application play-akka.actor.default-dispatcher-269 - Parsing SOAP ack (200) from urn:ogf:network:es.net:2013:nsa:nsi-requester at https://nsi-aggr-west.es.net/requester/reply: <soapenv:Envelope xmlns:xs="http://www.w3.org/2001/XMLSchema" xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance" xmlns:gns="http://nordu.net/namespaces/2013/12/gnsbod" xmlns:saml="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:type="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:head="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/">
<soapenv:Header>
<head:nsiHeader>
<protocolVersion>application/vnd.ogf.nsi.cs.v2.requester+soap</protocolVersion>
<correlationId>urn:uuid:02ccdcef-19a1-468c-afb4-331b9cc026e6</correlationId>
<requesterNSA>urn:ogf:network:es.net:2013:nsa:nsi-requester</requesterNSA>
<providerNSA>urn:ogf:network:es.net:2013:nsa:nsi-aggr-west</providerNSA>
</head:nsiHeader>
</soapenv:Header>
<soapenv:Body>
<type:acknowledgment/>
</soapenv:Body>
</soapenv:Envelope> -
2014-06-25 20:43:00,999 DEBUG application play-akka.actor.default-dispatcher-269 - Received ack from urn:ogf:network:es.net:2013:nsa:nsi-requester at https://nsi-aggr-west.es.net/requester/reply: NsiRequesterMessage(NsiHeaders(urn:uuid:02ccdcef-19a1-468c-afb4-331b9cc026e6,urn:ogf:network:es.net:2013:nsa:nsi-requester,urn:ogf:network:es.net:2013:nsa:nsi-aggr-west,None,application/vnd.ogf.nsi.cs.v2.requester+soap,List(),List()),GenericAck()) -
2014-06-25 20:43:00,999 DEBUG application play-akka.actor.default-dispatcher-269 - Replying ProvisionConfirmed(494e60a6-db7f-4285-9e66-500289299731) to https://nsi-aggr-west.es.net/requester/reply succeeded with NsiRequesterMessage(NsiHeaders(urn:uuid:02ccdcef-19a1-468c-afb4-331b9cc026e6,urn:ogf:network:es.net:2013:nsa:nsi-requester,urn:ogf:network:es.net:2013:nsa:nsi-aggr-west,None,application/vnd.ogf.nsi.cs.v2.requester+soap,List(),List()),GenericAck()) -
2014-06-25 20:43:22,870 DEBUG application play-akka.actor.default-dispatcher-266 - received SOAP message /nsi-v2/ConnectionServiceProvider from 127.0.0.1 with content-type Some(text/xml) <soapenv:Envelope xmlns:xs="http://www.w3.org/2001/XMLSchema" xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance" xmlns:gns="http://nordu.net/namespaces/2013/12/gnsbod" xmlns:saml="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:type="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:head="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/">
<soapenv:Header>
<head:nsiHeader>
<protocolVersion>application/vnd.ogf.nsi.cs.v2.provider+soap</protocolVersion>
<correlationId>urn:uuid:c87fd632-0283-4ab9-bf69-e79a05ea21c5</correlationId>
<requesterNSA>urn:ogf:network:es.net:2013:nsa:nsi-requester</requesterNSA>
<providerNSA>urn:ogf:network:es.net:2013:nsa:nsi-aggr-west</providerNSA>
<replyTo>https://nsi-aggr-west.es.net/requester/reply</replyTo>
</head:nsiHeader>
</soapenv:Header>
<soapenv:Body>
<type:querySummary>
<connectionId>494e60a6-db7f-4285-9e66-500289299731</connectionId>
</type:querySummary>
</soapenv:Body>
</soapenv:Envelope> -
2014-06-25 20:43:22,873 DEBUG application play-akka.actor.default-dispatcher-266 - SOAP message parse result Success([#document: null]) -
2014-06-25 20:43:22,876 DEBUG application play-internal-execution-context-1 - Received (/nsi-v2/ConnectionServiceProvider): Success(NsiProviderMessage(NsiHeaders(urn:uuid:c87fd632-0283-4ab9-bf69-e79a05ea21c5,urn:ogf:network:es.net:2013:nsa:nsi-requester,urn:ogf:network:es.net:2013:nsa:nsi-aggr-west,Some(https://nsi-aggr-west.es.net/requester/reply),application/vnd.ogf.nsi.cs.v2.provider+soap,List(),List()),QuerySummary(Some(Left(Buffer(494e60a6-db7f-4285-9e66-500289299731)))))) -
2014-06-25 20:43:22,881 DEBUG application play-akka.actor.default-dispatcher-266 - Ack 127.0.0.1 with Success(<?xml version="1.0" encoding="UTF-8" standalone="no"?><soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/"><soapenv:Header><ns7:nsiHeader xmlns:ns2="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns3="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:ns4="http://www.w3.org/2001/04/xmlenc#" xmlns:ns5="http://www.w3.org/2000/09/xmldsig#" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point" xmlns:ns9="http://nordu.net/namespaces/2013/12/gnsbod"><protocolVersion>application/vnd.ogf.nsi.cs.v2.provider+soap</protocolVersion><correlationId>urn:uuid:c87fd632-0283-4ab9-bf69-e79a05ea21c5</correlationId><requesterNSA>urn:ogf:network:es.net:2013:nsa:nsi-requester</requesterNSA><providerNSA>urn:ogf:network:es.net:2013:nsa:nsi-aggr-west</providerNSA></ns7:nsiHeader></soapenv:Header><soapenv:Body><ns2:acknowledgment xmlns:ns2="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns3="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:ns4="http://www.w3.org/2001/04/xmlenc#" xmlns:ns5="http://www.w3.org/2000/09/xmldsig#" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point" xmlns:ns9="http://nordu.net/namespaces/2013/12/gnsbod"/></soapenv:Body></soapenv:Envelope>) -
2014-06-25 20:43:22,883 DEBUG application play-akka.actor.default-dispatcher-268 - Sending provider urn:ogf:network:es.net:2013:nsa:nsi-requester at https://nsi-aggr-west.es.net/requester/reply the SOAP message: Success(<?xml version="1.0" encoding="UTF-8" standalone="no"?><soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/"><soapenv:Header><ns7:nsiHeader xmlns:ns2="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns3="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:ns4="http://www.w3.org/2001/04/xmlenc#" xmlns:ns5="http://www.w3.org/2000/09/xmldsig#" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point" xmlns:ns9="http://nordu.net/namespaces/2013/12/gnsbod"><protocolVersion>application/vnd.ogf.nsi.cs.v2.provider+soap</protocolVersion><correlationId>urn:uuid:c87fd632-0283-4ab9-bf69-e79a05ea21c5</correlationId><requesterNSA>urn:ogf:network:es.net:2013:nsa:nsi-requester</requesterNSA><providerNSA>urn:ogf:network:es.net:2013:nsa:nsi-aggr-west</providerNSA></ns7:nsiHeader></soapenv:Header><soapenv:Body><ns2:querySummaryConfirmed xmlns:ns2="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns3="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:ns4="http://www.w3.org/2001/04/xmlenc#" xmlns:ns5="http://www.w3.org/2000/09/xmldsig#" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point" xmlns:ns9="http://nordu.net/namespaces/2013/12/gnsbod"><reservation><connectionId>494e60a6-db7f-4285-9e66-500289299731</connectionId><globalReservationId>urn:uuid:2888ca60-e612-11e3-ac10-0800200c9998</globalReservationId><description>Test: Terminate after end time</description><criteria version="1"><schedule><startTime>2014-06-25T20:45:00.000-07:00</startTime><endTime>2014-06-25T20:50:00.000-07:00</endTime></schedule><serviceType>http://services.ogf.org/nsi/2013/12/descriptions/EVTS.A-GOLE</serviceType><children><child order="0"><connectionId>urn:uuid:c2944c2e-c464-4c76-805d-f0f57cb7981b</connectionId><providerNSA>urn:ogf:network:es.net:2013:nsa</providerNSA><serviceType>http://services.ogf.org/nsi/2013/12/descriptions/EVTS.A-GOLE</serviceType><ns8:p2ps><capacity>100</capacity><directionality>Bidirectional</directionality><symmetricPath>true</symmetricPath><sourceSTP>urn:ogf:network:es.net:2013:ps:sunn:1?vlan=1780</sourceSTP><destSTP>urn:ogf:network:es.net:2013:manlan:aofa:1?vlan=1780</destSTP></ns8:p2ps></child><child order="1"><connectionId>urn:uuid:a46f19fa-fd4d-4bc5-ad68-390604bcf6fa</connectionId><providerNSA>urn:ogf:network:manlan.internet2.edu:2013:nsa</providerNSA><serviceType>http://services.ogf.org/nsi/2013/12/descriptions/EVTS.A-GOLE</serviceType><ns8:p2ps><capacity>100</capacity><directionality>Bidirectional</directionality><symmetricPath>true</symmetricPath><sourceSTP>urn:ogf:network:manlan.internet2.edu:2013:es?vlan=1780</sourceSTP><destSTP>urn:ogf:network:manlan.internet2.edu:2013:netherlight?vlan=1780</destSTP></ns8:p2ps></child></children><ns8:p2ps><capacity>100</capacity><directionality>Bidirectional</directionality><symmetricPath>true</symmetricPath><sourceSTP>urn:ogf:network:es.net:2013:ps:sunn:1?vlan=1780</sourceSTP><destSTP>urn:ogf:network:manlan.internet2.edu:2013:netherlight?vlan=1780</destSTP><parameter type="protection">UNPROTECTED</parameter></ns8:p2ps></criteria><requesterNSA>urn:ogf:network:es.net:2013:nsa:nsi-requester</requesterNSA><connectionStates><reservationState>ReserveStart</reservationState><provisionState>Provisioned</provisionState><lifecycleState>Created</lifecycleState><dataPlaneStatus><active>false</active><version>1</version><versionConsistent>true</versionConsistent></dataPlaneStatus></connectionStates></reservation></ns2:querySummaryConfirmed></soapenv:Body></soapenv:Envelope>) -
2014-06-25 20:43:23,028 DEBUG application play-akka.actor.default-dispatcher-268 - Parsing SOAP ack (200) from urn:ogf:network:es.net:2013:nsa:nsi-requester at https://nsi-aggr-west.es.net/requester/reply: <soapenv:Envelope xmlns:xs="http://www.w3.org/2001/XMLSchema" xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance" xmlns:gns="http://nordu.net/namespaces/2013/12/gnsbod" xmlns:saml="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:type="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:head="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/">
<soapenv:Header>
<head:nsiHeader>
<protocolVersion>application/vnd.ogf.nsi.cs.v2.requester+soap</protocolVersion>
<correlationId>urn:uuid:c87fd632-0283-4ab9-bf69-e79a05ea21c5</correlationId>
<requesterNSA>urn:ogf:network:es.net:2013:nsa:nsi-requester</requesterNSA>
<providerNSA>urn:ogf:network:es.net:2013:nsa:nsi-aggr-west</providerNSA>
</head:nsiHeader>
</soapenv:Header>
<soapenv:Body>
<type:acknowledgment/>
</soapenv:Body>
</soapenv:Envelope> -
2014-06-25 20:43:23,033 DEBUG application play-akka.actor.default-dispatcher-268 - Received ack from urn:ogf:network:es.net:2013:nsa:nsi-requester at https://nsi-aggr-west.es.net/requester/reply: NsiRequesterMessage(NsiHeaders(urn:uuid:c87fd632-0283-4ab9-bf69-e79a05ea21c5,urn:ogf:network:es.net:2013:nsa:nsi-requester,urn:ogf:network:es.net:2013:nsa:nsi-aggr-west,None,application/vnd.ogf.nsi.cs.v2.requester+soap,List(),List()),GenericAck()) -
2014-06-25 20:43:23,035 DEBUG application play-akka.actor.default-dispatcher-268 - Replying QuerySummaryConfirmed(ArrayBuffer(org.ogf.schemas.nsi._2013._12.connection.types.QuerySummaryResultType@332c3933[connectionId=494e60a6-db7f-4285-9e66-500289299731, globalReservationId=urn:uuid:2888ca60-e612-11e3-ac10-0800200c9998, description=Test: Terminate after end time, criteria={org.ogf.schemas.nsi._2013._12.connection.types.QuerySummaryResultCriteriaType@59884864[schedule=org.ogf.schemas.nsi._2013._12.connection.types.ScheduleType@222b993e[startTime=2014-06-25T20:45:00.000-07:00, endTime=2014-06-25T20:50:00.000-07:00], serviceType=http://services.ogf.org/nsi/2013/12/descriptions/EVTS.A-GOLE, children=org.ogf.schemas.nsi._2013._12.connection.types.ChildSummaryListType@58c6dcc[child={org.ogf.schemas.nsi._2013._12.connection.types.ChildSummaryType@73bb18c3[connectionId=urn:uuid:c2944c2e-c464-4c76-805d-f0f57cb7981b, providerNSA=urn:ogf:network:es.net:2013:nsa, serviceType=http://services.ogf.org/nsi/2013/12/descriptions/EVTS.A-GOLE, any={<{http://schemas.ogf.org/nsi/2013/12/services/point2point}p2ps[org.ogf.schemas.nsi._2013._12.services.point2point.P2PServiceBaseType@522e209f[capacity=100, directionality=BIDIRECTIONAL, symmetricPath=true, sourceSTP=urn:ogf:network:es.net:2013:ps:sunn:1?vlan=1780, destSTP=urn:ogf:network:es.net:2013:manlan:aofa:1?vlan=1780, ero=<null>, parameter=<null>, any=<null>]]>}, order=0],org.ogf.schemas.nsi._2013._12.connection.types.ChildSummaryType@218c5226[connectionId=urn:uuid:a46f19fa-fd4d-4bc5-ad68-390604bcf6fa, providerNSA=urn:ogf:network:manlan.internet2.edu:2013:nsa, serviceType=http://services.ogf.org/nsi/2013/12/descriptions/EVTS.A-GOLE, any={<{http://schemas.ogf.org/nsi/2013/12/services/point2point}p2ps[org.ogf.schemas.nsi._2013._12.services.point2point.P2PServiceBaseType@1bf6bed2[capacity=100, directionality=BIDIRECTIONAL, symmetricPath=true, sourceSTP=urn:ogf:network:manlan.internet2.edu:2013:es?vlan=1780, destSTP=urn:ogf:network:manlan.internet2.edu:2013:netherlight?vlan=1780, ero=<null>, parameter=<null>, any=<null>]]>}, order=1]}], any={<{http://schemas.ogf.org/nsi/2013/12/services/point2point}p2ps[org.ogf.schemas.nsi._2013._12.services.point2point.P2PServiceBaseType@2cd2ec3f[capacity=100, directionality=BIDIRECTIONAL, symmetricPath=true, sourceSTP=urn:ogf:network:es.net:2013:ps:sunn:1?vlan=1780, destSTP=urn:ogf:network:manlan.internet2.edu:2013:netherlight?vlan=1780, ero=<null>, parameter={org.ogf.schemas.nsi._2013._12.services.types.TypeValueType@692fae4a[value=UNPROTECTED, type=protection]}, any=<null>]]>}, version=1]}, requesterNSA=urn:ogf:network:es.net:2013:nsa:nsi-requester, connectionStates=org.ogf.schemas.nsi._2013._12.connection.types.ConnectionStatesType@3a5ce51b[reservationState=RESERVE_START, provisionState=PROVISIONED, lifecycleState=CREATED, dataPlaneStatus=org.ogf.schemas.nsi._2013._12.connection.types.DataPlaneStatusType@5cd81d91[active=false, version=1, versionConsistent=true]], notificationId=<null>, resultId=<null>])) to https://nsi-aggr-west.es.net/requester/reply succeeded with NsiRequesterMessage(NsiHeaders(urn:uuid:c87fd632-0283-4ab9-bf69-e79a05ea21c5,urn:ogf:network:es.net:2013:nsa:nsi-requester,urn:ogf:network:es.net:2013:nsa:nsi-aggr-west,None,application/vnd.ogf.nsi.cs.v2.requester+soap,List(),List()),GenericAck()) -
2014-06-25 20:46:00,442 DEBUG application play-akka.actor.default-dispatcher-272 - received SOAP message /nsi-v2/ConnectionServiceRequester from 140.182.45.16 with content-type Some(text/xml) <soap:Envelope xmlns:soap="http://schemas.xmlsoap.org/soap/envelope/"><soap:Header><ns7:nsiHeader xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns5="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns4="http://www.w3.org/2000/09/xmldsig#" xmlns:ns3="http://www.w3.org/2001/04/xmlenc#" xmlns:ns2="urn:oasis:names:tc:SAML:2.0:assertion"><protocolVersion>application/vdn.ogf.nsi.cs.v2.provider+soap</protocolVersion><correlationId>urn:uuid:00c729a3-21f7-479f-8119-e25956507137</correlationId><requesterNSA>urn:ogf:network:es.net:2013:nsa:nsi-aggr-west</requesterNSA><providerNSA>urn:ogf:network:manlan.internet2.edu</providerNSA></ns7:nsiHeader></soap:Header><soap:Body><ns5:dataPlaneStateChange xmlns:ns2="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:ns3="http://www.w3.org/2001/04/xmlenc#" xmlns:ns4="http://www.w3.org/2000/09/xmldsig#" xmlns:ns5="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point"><connectionId>urn:uuid:a46f19fa-fd4d-4bc5-ad68-390604bcf6fa</connectionId><notificationId>18</notificationId><timeStamp>2014-06-26T03:45:18.670Z</timeStamp><dataPlaneStatus><active>true</active><version>1</version><versionConsistent>true</versionConsistent></dataPlaneStatus></ns5:dataPlaneStateChange></soap:Body></soap:Envelope> -
2014-06-25 20:46:00,446 DEBUG application play-akka.actor.default-dispatcher-272 - SOAP message parse result Success([#document: null]) -
2014-06-25 20:46:00,449 DEBUG application play-internal-execution-context-1 - Received (/nsi-v2/ConnectionServiceRequester): Success(NsiRequesterMessage(NsiHeaders(urn:uuid:00c729a3-21f7-479f-8119-e25956507137,urn:ogf:network:es.net:2013:nsa:nsi-aggr-west,urn:ogf:network:manlan.internet2.edu,None,application/vdn.ogf.nsi.cs.v2.provider+soap,List(),List()),DataPlaneStateChange(org.ogf.schemas.nsi._2013._12.connection.types.DataPlaneStateChangeRequestType@13777e14[connectionId=urn:uuid:a46f19fa-fd4d-4bc5-ad68-390604bcf6fa, notificationId=18, timeStamp=2014-06-26T03:45:18.670Z, dataPlaneStatus=org.ogf.schemas.nsi._2013._12.connection.types.DataPlaneStatusType@438a0780[active=true, version=1, versionConsistent=true]]))) -
2014-06-25 20:46:00,451 DEBUG application application-akka.actor.default-dispatcher-242 - state change from false to false -
2014-06-25 20:46:00,497 DEBUG application application-akka.actor.default-dispatcher-242 - Scheduling Command(2014-06-26T03:50:00.000Z,PassedEndTime(urn:uuid:82ac864e-b0ef-4f1e-925a-5ab5972fa38a,494e60a6-db7f-4285-9e66-500289299731,2014-06-25T20:50:00.000-07:00)) for execution after 239504 milliseconds -
2014-06-25 20:46:00,501 DEBUG application play-akka.actor.default-dispatcher-271 - Ack 140.182.45.16 with Success(<?xml version="1.0" encoding="UTF-8" standalone="no"?><soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/"><soapenv:Header><ns7:nsiHeader xmlns:ns2="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns3="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:ns4="http://www.w3.org/2001/04/xmlenc#" xmlns:ns5="http://www.w3.org/2000/09/xmldsig#" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point" xmlns:ns9="http://nordu.net/namespaces/2013/12/gnsbod"><protocolVersion>application/vnd.ogf.nsi.cs.v2.requester+soap</protocolVersion><correlationId>urn:uuid:00c729a3-21f7-479f-8119-e25956507137</correlationId><requesterNSA>urn:ogf:network:es.net:2013:nsa:nsi-aggr-west</requesterNSA><providerNSA>urn:ogf:network:manlan.internet2.edu</providerNSA></ns7:nsiHeader></soapenv:Header><soapenv:Body><ns2:acknowledgment xmlns:ns2="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns3="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:ns4="http://www.w3.org/2001/04/xmlenc#" xmlns:ns5="http://www.w3.org/2000/09/xmldsig#" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point" xmlns:ns9="http://nordu.net/namespaces/2013/12/gnsbod"/></soapenv:Body></soapenv:Envelope>) -
2014-06-25 20:46:10,776 DEBUG application play-akka.actor.default-dispatcher-272 - received SOAP message /nsi-v2/ConnectionServiceRequester from 198.128.14.168 with content-type Some(text/xml) <soap:Envelope xmlns:soap="http://schemas.xmlsoap.org/soap/envelope/"><soap:Header><ns7:nsiHeader xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns5="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns4="http://www.w3.org/2000/09/xmldsig#" xmlns:ns3="http://www.w3.org/2001/04/xmlenc#" xmlns:ns2="urn:oasis:names:tc:SAML:2.0:assertion"><protocolVersion>application/vdn.ogf.nsi.cs.v2.provider+soap</protocolVersion><correlationId>urn:uuid:b26a37d0-5185-4007-bc9e-b2b1c0cd26e8</correlationId><requesterNSA>urn:ogf:network:es.net:2013:nsa:nsi-aggr-west</requesterNSA><providerNSA>urn:ogf:network:nsa:es.net</providerNSA></ns7:nsiHeader></soap:Header><soap:Body><ns5:dataPlaneStateChange xmlns:ns2="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:ns3="http://www.w3.org/2001/04/xmlenc#" xmlns:ns4="http://www.w3.org/2000/09/xmldsig#" xmlns:ns5="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point"><connectionId>urn:uuid:c2944c2e-c464-4c76-805d-f0f57cb7981b</connectionId><notificationId>25</notificationId><timeStamp>2014-06-25T20:45:31.158-07:00</timeStamp><dataPlaneStatus><active>true</active><version>1</version><versionConsistent>true</versionConsistent></dataPlaneStatus></ns5:dataPlaneStateChange></soap:Body></soap:Envelope> -
2014-06-25 20:46:10,779 DEBUG application play-akka.actor.default-dispatcher-272 - SOAP message parse result Success([#document: null]) -
2014-06-25 20:46:10,782 DEBUG application play-internal-execution-context-1 - Received (/nsi-v2/ConnectionServiceRequester): Success(NsiRequesterMessage(NsiHeaders(urn:uuid:b26a37d0-5185-4007-bc9e-b2b1c0cd26e8,urn:ogf:network:es.net:2013:nsa:nsi-aggr-west,urn:ogf:network:nsa:es.net,None,application/vdn.ogf.nsi.cs.v2.provider+soap,List(),List()),DataPlaneStateChange(org.ogf.schemas.nsi._2013._12.connection.types.DataPlaneStateChangeRequestType@1d4562a4[connectionId=urn:uuid:c2944c2e-c464-4c76-805d-f0f57cb7981b, notificationId=25, timeStamp=2014-06-25T20:45:31.158-07:00, dataPlaneStatus=org.ogf.schemas.nsi._2013._12.connection.types.DataPlaneStatusType@6abc6e8e[active=true, version=1, versionConsistent=true]]))) -
2014-06-25 20:46:10,784 DEBUG application application-akka.actor.default-dispatcher-247 - state change from false to true -
2014-06-25 20:46:10,846 DEBUG application application-akka.actor.default-dispatcher-247 - Scheduling Command(2014-06-26T03:50:00.000Z,PassedEndTime(urn:uuid:54e87f05-43af-4d8e-88ad-7fe3cdf3b2f5,494e60a6-db7f-4285-9e66-500289299731,2014-06-25T20:50:00.000-07:00)) for execution after 229154 milliseconds -
2014-06-25 20:46:10,852 DEBUG application application-akka.actor.default-dispatcher-248 - Sending provider urn:ogf:network:es.net:2013:nsa:nsi-requester at https://nsi-aggr-west.es.net/requester/reply the SOAP message: Success(<?xml version="1.0" encoding="UTF-8" standalone="no"?><soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/"><soapenv:Header><ns7:nsiHeader xmlns:ns2="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns3="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:ns4="http://www.w3.org/2001/04/xmlenc#" xmlns:ns5="http://www.w3.org/2000/09/xmldsig#" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point" xmlns:ns9="http://nordu.net/namespaces/2013/12/gnsbod"><protocolVersion>application/vnd.ogf.nsi.cs.v2.provider+soap</protocolVersion><correlationId>urn:uuid:d0735d1a-6ee8-43ac-b467-7c1ac7233a2b</correlationId><requesterNSA>urn:ogf:network:es.net:2013:nsa:nsi-requester</requesterNSA><providerNSA>urn:ogf:network:es.net:2013:nsa:nsi-aggr-west</providerNSA></ns7:nsiHeader></soapenv:Header><soapenv:Body><ns2:dataPlaneStateChange xmlns:ns2="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns3="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:ns4="http://www.w3.org/2001/04/xmlenc#" xmlns:ns5="http://www.w3.org/2000/09/xmldsig#" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point" xmlns:ns9="http://nordu.net/namespaces/2013/12/gnsbod"><connectionId>494e60a6-db7f-4285-9e66-500289299731</connectionId><notificationId>1</notificationId><timeStamp>2014-06-25T20:45:31.158-07:00</timeStamp><dataPlaneStatus><active>true</active><version>0</version><versionConsistent>true</versionConsistent></dataPlaneStatus></ns2:dataPlaneStateChange></soapenv:Body></soapenv:Envelope>) -
2014-06-25 20:46:10,861 DEBUG application play-akka.actor.default-dispatcher-272 - Ack 198.128.14.168 with Success(<?xml version="1.0" encoding="UTF-8" standalone="no"?><soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/"><soapenv:Header><ns7:nsiHeader xmlns:ns2="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns3="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:ns4="http://www.w3.org/2001/04/xmlenc#" xmlns:ns5="http://www.w3.org/2000/09/xmldsig#" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point" xmlns:ns9="http://nordu.net/namespaces/2013/12/gnsbod"><protocolVersion>application/vnd.ogf.nsi.cs.v2.requester+soap</protocolVersion><correlationId>urn:uuid:b26a37d0-5185-4007-bc9e-b2b1c0cd26e8</correlationId><requesterNSA>urn:ogf:network:es.net:2013:nsa:nsi-aggr-west</requesterNSA><providerNSA>urn:ogf:network:nsa:es.net</providerNSA></ns7:nsiHeader></soapenv:Header><soapenv:Body><ns2:acknowledgment xmlns:ns2="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns3="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:ns4="http://www.w3.org/2001/04/xmlenc#" xmlns:ns5="http://www.w3.org/2000/09/xmldsig#" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point" xmlns:ns9="http://nordu.net/namespaces/2013/12/gnsbod"/></soapenv:Body></soapenv:Envelope>) -
2014-06-25 20:46:10,999 DEBUG application play-akka.actor.default-dispatcher-272 - Parsing SOAP ack (200) from urn:ogf:network:es.net:2013:nsa:nsi-requester at https://nsi-aggr-west.es.net/requester/reply: <soapenv:Envelope xmlns:xs="http://www.w3.org/2001/XMLSchema" xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance" xmlns:gns="http://nordu.net/namespaces/2013/12/gnsbod" xmlns:saml="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:type="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:head="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/">
<soapenv:Header>
<head:nsiHeader>
<protocolVersion>application/vnd.ogf.nsi.cs.v2.requester+soap</protocolVersion>
<correlationId>urn:uuid:d0735d1a-6ee8-43ac-b467-7c1ac7233a2b</correlationId>
<requesterNSA>urn:ogf:network:es.net:2013:nsa:nsi-requester</requesterNSA>
<providerNSA>urn:ogf:network:es.net:2013:nsa:nsi-aggr-west</providerNSA>
</head:nsiHeader>
</soapenv:Header>
<soapenv:Body>
<type:acknowledgment/>
</soapenv:Body>
</soapenv:Envelope> -
2014-06-25 20:46:11,004 DEBUG application play-akka.actor.default-dispatcher-272 - Received ack from urn:ogf:network:es.net:2013:nsa:nsi-requester at https://nsi-aggr-west.es.net/requester/reply: NsiRequesterMessage(NsiHeaders(urn:uuid:d0735d1a-6ee8-43ac-b467-7c1ac7233a2b,urn:ogf:network:es.net:2013:nsa:nsi-requester,urn:ogf:network:es.net:2013:nsa:nsi-aggr-west,None,application/vnd.ogf.nsi.cs.v2.requester+soap,List(),List()),GenericAck()) -
2014-06-25 20:46:11,005 DEBUG application play-akka.actor.default-dispatcher-272 - Replying DataPlaneStateChange(org.ogf.schemas.nsi._2013._12.connection.types.DataPlaneStateChangeRequestType@599e9c34[connectionId=494e60a6-db7f-4285-9e66-500289299731, notificationId=1, timeStamp=2014-06-25T20:45:31.158-07:00, dataPlaneStatus=org.ogf.schemas.nsi._2013._12.connection.types.DataPlaneStatusType@19fa293[active=true, version=0, versionConsistent=true]]) to https://nsi-aggr-west.es.net/requester/reply succeeded with NsiRequesterMessage(NsiHeaders(urn:uuid:d0735d1a-6ee8-43ac-b467-7c1ac7233a2b,urn:ogf:network:es.net:2013:nsa:nsi-requester,urn:ogf:network:es.net:2013:nsa:nsi-aggr-west,None,application/vnd.ogf.nsi.cs.v2.requester+soap,List(),List()),GenericAck()) -
2014-06-25 20:50:00,020 DEBUG application application-akka.actor.default-dispatcher-246 - state change from CREATED to PASSED_END_TIME -
2014-06-25 20:50:00,050 DEBUG application application-akka.actor.default-dispatcher-246 - Scheduling Delete for execution after 86399950 milliseconds -
2014-06-25 20:51:40,593 DEBUG application play-akka.actor.default-dispatcher-278 - received SOAP message /nsi-v2/ConnectionServiceProvider from 127.0.0.1 with content-type Some(text/xml) <soapenv:Envelope xmlns:xs="http://www.w3.org/2001/XMLSchema" xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance" xmlns:gns="http://nordu.net/namespaces/2013/12/gnsbod" xmlns:saml="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:type="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:head="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/">
<soapenv:Header>
<head:nsiHeader>
<protocolVersion>application/vnd.ogf.nsi.cs.v2.provider+soap</protocolVersion>
<correlationId>urn:uuid:bb3697d6-c35e-4259-ba37-c551ed6dbd27</correlationId>
<requesterNSA>urn:ogf:network:es.net:2013:nsa:nsi-requester</requesterNSA>
<providerNSA>urn:ogf:network:es.net:2013:nsa:nsi-aggr-west</providerNSA>
<replyTo>https://nsi-aggr-west.es.net/requester/reply</replyTo>
</head:nsiHeader>
</soapenv:Header>
<soapenv:Body>
<type:terminate>
<connectionId>494e60a6-db7f-4285-9e66-500289299731</connectionId>
</type:terminate>
</soapenv:Body>
</soapenv:Envelope> -
2014-06-25 20:51:40,596 DEBUG application play-akka.actor.default-dispatcher-278 - SOAP message parse result Success([#document: null]) -
2014-06-25 20:51:40,599 DEBUG application play-internal-execution-context-1 - Received (/nsi-v2/ConnectionServiceProvider): Success(NsiProviderMessage(NsiHeaders(urn:uuid:bb3697d6-c35e-4259-ba37-c551ed6dbd27,urn:ogf:network:es.net:2013:nsa:nsi-requester,urn:ogf:network:es.net:2013:nsa:nsi-aggr-west,Some(https://nsi-aggr-west.es.net/requester/reply),application/vnd.ogf.nsi.cs.v2.provider+soap,List(),List()),Terminate(494e60a6-db7f-4285-9e66-500289299731))) -
2014-06-25 20:51:40,602 DEBUG application application-akka.actor.default-dispatcher-265 - state change from PASSED_END_TIME to TERMINATING -
2014-06-25 20:51:40,724 DEBUG application application-akka.actor.default-dispatcher-265 - Scheduling Delete for execution after 86399877 milliseconds -
2014-06-25 20:51:40,729 DEBUG application play-akka.actor.default-dispatcher-278 - Ack 127.0.0.1 with Success(<?xml version="1.0" encoding="UTF-8" standalone="no"?><soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/"><soapenv:Header><ns7:nsiHeader xmlns:ns2="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns3="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:ns4="http://www.w3.org/2001/04/xmlenc#" xmlns:ns5="http://www.w3.org/2000/09/xmldsig#" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point" xmlns:ns9="http://nordu.net/namespaces/2013/12/gnsbod"><protocolVersion>application/vnd.ogf.nsi.cs.v2.provider+soap</protocolVersion><correlationId>urn:uuid:bb3697d6-c35e-4259-ba37-c551ed6dbd27</correlationId><requesterNSA>urn:ogf:network:es.net:2013:nsa:nsi-requester</requesterNSA><providerNSA>urn:ogf:network:es.net:2013:nsa:nsi-aggr-west</providerNSA></ns7:nsiHeader></soapenv:Header><soapenv:Body><ns2:acknowledgment xmlns:ns2="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns3="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:ns4="http://www.w3.org/2001/04/xmlenc#" xmlns:ns5="http://www.w3.org/2000/09/xmldsig#" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point" xmlns:ns9="http://nordu.net/namespaces/2013/12/gnsbod"/></soapenv:Body></soapenv:Envelope>) -
2014-06-25 20:51:40,729 DEBUG application application-akka.actor.default-dispatcher-262 - Sending provider urn:ogf:network:es.net:2013:nsa at https://oscars.es.net/ConnectionService the SOAP message: Success(<?xml version="1.0" encoding="UTF-8" standalone="no"?><soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/"><soapenv:Header><ns7:nsiHeader xmlns:ns2="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns3="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:ns4="http://www.w3.org/2001/04/xmlenc#" xmlns:ns5="http://www.w3.org/2000/09/xmldsig#" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point" xmlns:ns9="http://nordu.net/namespaces/2013/12/gnsbod"><protocolVersion>application/vnd.ogf.nsi.cs.v2.provider+soap</protocolVersion><correlationId>urn:uuid:eab6f996-484d-4181-9233-58eb33d7fa54</correlationId><requesterNSA>urn:ogf:network:es.net:2013:nsa:nsi-aggr-west</requesterNSA><providerNSA>urn:ogf:network:es.net:2013:nsa</providerNSA><replyTo>https://nsi-aggr-west.es.net/nsi-v2/ConnectionServiceRequester</replyTo></ns7:nsiHeader></soapenv:Header><soapenv:Body><ns2:terminate xmlns:ns2="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns3="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:ns4="http://www.w3.org/2001/04/xmlenc#" xmlns:ns5="http://www.w3.org/2000/09/xmldsig#" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point" xmlns:ns9="http://nordu.net/namespaces/2013/12/gnsbod"><connectionId>urn:uuid:c2944c2e-c464-4c76-805d-f0f57cb7981b</connectionId></ns2:terminate></soapenv:Body></soapenv:Envelope>) -
2014-06-25 20:51:40,777 DEBUG application application-akka.actor.default-dispatcher-262 - Sending provider urn:ogf:network:manlan.internet2.edu:2013:nsa at https://oscars.manlan.internet2.edu:8500/ConnectionServiceProvider the SOAP message: Success(<?xml version="1.0" encoding="UTF-8" standalone="no"?><soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/"><soapenv:Header><ns7:nsiHeader xmlns:ns2="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns3="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:ns4="http://www.w3.org/2001/04/xmlenc#" xmlns:ns5="http://www.w3.org/2000/09/xmldsig#" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point" xmlns:ns9="http://nordu.net/namespaces/2013/12/gnsbod"><protocolVersion>application/vnd.ogf.nsi.cs.v2.provider+soap</protocolVersion><correlationId>urn:uuid:65697f03-ec46-470d-8c4a-c28739cc863e</correlationId><requesterNSA>urn:ogf:network:es.net:2013:nsa:nsi-aggr-west</requesterNSA><providerNSA>urn:ogf:network:manlan.internet2.edu:2013:nsa</providerNSA><replyTo>https://nsi-aggr-west.es.net/nsi-v2/ConnectionServiceRequester</replyTo></ns7:nsiHeader></soapenv:Header><soapenv:Body><ns2:terminate xmlns:ns2="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns3="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:ns4="http://www.w3.org/2001/04/xmlenc#" xmlns:ns5="http://www.w3.org/2000/09/xmldsig#" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point" xmlns:ns9="http://nordu.net/namespaces/2013/12/gnsbod"><connectionId>urn:uuid:a46f19fa-fd4d-4bc5-ad68-390604bcf6fa</connectionId></ns2:terminate></soapenv:Body></soapenv:Envelope>) -
2014-06-25 20:51:41,169 DEBUG application play-akka.actor.default-dispatcher-278 - Parsing SOAP ack (200) from urn:ogf:network:es.net:2013:nsa at https://oscars.es.net/ConnectionService: <soap:Envelope xmlns:soap="http://schemas.xmlsoap.org/soap/envelope/"><soap:Header><ns6:nsiHeader xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns5="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns4="http://www.w3.org/2000/09/xmldsig#" xmlns:ns3="http://www.w3.org/2001/04/xmlenc#" xmlns:ns2="urn:oasis:names:tc:SAML:2.0:assertion"><protocolVersion>application/vnd.ogf.nsi.cs.v2.provider+soap</protocolVersion><correlationId>urn:uuid:eab6f996-484d-4181-9233-58eb33d7fa54</correlationId><requesterNSA>urn:ogf:network:es.net:2013:nsa:nsi-aggr-west</requesterNSA><providerNSA>urn:ogf:network:es.net:2013:nsa</providerNSA></ns6:nsiHeader></soap:Header><soap:Body><ns5:acknowledgment xmlns:ns2="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:ns3="http://www.w3.org/2001/04/xmlenc#" xmlns:ns4="http://www.w3.org/2000/09/xmldsig#" xmlns:ns5="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point"/></soap:Body></soap:Envelope> -
2014-06-25 20:51:41,174 DEBUG application play-akka.actor.default-dispatcher-278 - Received ack from urn:ogf:network:es.net:2013:nsa at https://oscars.es.net/ConnectionService: NsiProviderMessage(NsiHeaders(urn:uuid:eab6f996-484d-4181-9233-58eb33d7fa54,urn:ogf:network:es.net:2013:nsa:nsi-aggr-west,urn:ogf:network:es.net:2013:nsa,None,application/vnd.ogf.nsi.cs.v2.provider+soap,List(),List()),GenericAck()) -
2014-06-25 20:51:41,175 DEBUG application application-akka.actor.default-dispatcher-262 - state change from TERMINATING to TERMINATING -
2014-06-25 20:51:41,196 DEBUG application play-akka.actor.default-dispatcher-278 - Parsing SOAP ack (200) from urn:ogf:network:manlan.internet2.edu:2013:nsa at https://oscars.manlan.internet2.edu:8500/ConnectionServiceProvider: <soap:Envelope xmlns:soap="http://schemas.xmlsoap.org/soap/envelope/"><soap:Header><ns6:nsiHeader xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns5="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns4="http://www.w3.org/2000/09/xmldsig#" xmlns:ns3="http://www.w3.org/2001/04/xmlenc#" xmlns:ns2="urn:oasis:names:tc:SAML:2.0:assertion"><protocolVersion>application/vnd.ogf.nsi.cs.v2.provider+soap</protocolVersion><correlationId>urn:uuid:65697f03-ec46-470d-8c4a-c28739cc863e</correlationId><requesterNSA>urn:ogf:network:es.net:2013:nsa:nsi-aggr-west</requesterNSA><providerNSA>urn:ogf:network:manlan.internet2.edu:2013:nsa</providerNSA></ns6:nsiHeader></soap:Header><soap:Body><ns5:acknowledgment xmlns:ns2="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:ns3="http://www.w3.org/2001/04/xmlenc#" xmlns:ns4="http://www.w3.org/2000/09/xmldsig#" xmlns:ns5="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point"/></soap:Body></soap:Envelope> -
2014-06-25 20:51:41,202 DEBUG application play-akka.actor.default-dispatcher-278 - Received ack from urn:ogf:network:manlan.internet2.edu:2013:nsa at https://oscars.manlan.internet2.edu:8500/ConnectionServiceProvider: NsiProviderMessage(NsiHeaders(urn:uuid:65697f03-ec46-470d-8c4a-c28739cc863e,urn:ogf:network:es.net:2013:nsa:nsi-aggr-west,urn:ogf:network:manlan.internet2.edu:2013:nsa,None,application/vnd.ogf.nsi.cs.v2.provider+soap,List(),List()),GenericAck()) -
2014-06-25 20:51:41,208 DEBUG application application-akka.actor.default-dispatcher-262 - Scheduling Delete for execution after 86399966 milliseconds -
2014-06-25 20:51:41,209 DEBUG application application-akka.actor.default-dispatcher-262 - state change from TERMINATING to TERMINATING -
2014-06-25 20:51:41,239 DEBUG application application-akka.actor.default-dispatcher-262 - Scheduling Delete for execution after 86399963 milliseconds -
2014-06-25 20:51:44,813 DEBUG application play-akka.actor.default-dispatcher-278 - received SOAP message /nsi-v2/ConnectionServiceRequester from 140.182.45.16 with content-type Some(text/xml) <soap:Envelope xmlns:soap="http://schemas.xmlsoap.org/soap/envelope/"><soap:Header><ns7:nsiHeader xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns5="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns4="http://www.w3.org/2000/09/xmldsig#" xmlns:ns3="http://www.w3.org/2001/04/xmlenc#" xmlns:ns2="urn:oasis:names:tc:SAML:2.0:assertion"><protocolVersion>application/vdn.ogf.nsi.cs.v2.provider+soap</protocolVersion><correlationId>urn:uuid:65697f03-ec46-470d-8c4a-c28739cc863e</correlationId><requesterNSA>urn:ogf:network:es.net:2013:nsa:nsi-aggr-west</requesterNSA><providerNSA>urn:ogf:network:manlan.internet2.edu</providerNSA><replyTo>https://oscars.bldc.manlan.internet2.edu:8500//ConnectionService</replyTo></ns7:nsiHeader></soap:Header><soap:Body><ns5:terminateConfirmed xmlns:ns2="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:ns3="http://www.w3.org/2001/04/xmlenc#" xmlns:ns4="http://www.w3.org/2000/09/xmldsig#" xmlns:ns5="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point"><connectionId>urn:uuid:a46f19fa-fd4d-4bc5-ad68-390604bcf6fa</connectionId></ns5:terminateConfirmed></soap:Body></soap:Envelope> -
2014-06-25 20:51:44,816 DEBUG application play-akka.actor.default-dispatcher-278 - SOAP message parse result Success([#document: null]) -
2014-06-25 20:51:44,819 DEBUG application play-internal-execution-context-1 - Received (/nsi-v2/ConnectionServiceRequester): Success(NsiRequesterMessage(NsiHeaders(urn:uuid:65697f03-ec46-470d-8c4a-c28739cc863e,urn:ogf:network:es.net:2013:nsa:nsi-aggr-west,urn:ogf:network:manlan.internet2.edu,Some(https://oscars.bldc.manlan.internet2.edu:8500//ConnectionService),application/vdn.ogf.nsi.cs.v2.provider+soap,List(),List()),TerminateConfirmed(urn:uuid:a46f19fa-fd4d-4bc5-ad68-390604bcf6fa))) -
2014-06-25 20:51:44,824 DEBUG application play-akka.actor.default-dispatcher-281 - Ack 140.182.45.16 with Success(<?xml version="1.0" encoding="UTF-8" standalone="no"?><soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/"><soapenv:Header><ns7:nsiHeader xmlns:ns2="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns3="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:ns4="http://www.w3.org/2001/04/xmlenc#" xmlns:ns5="http://www.w3.org/2000/09/xmldsig#" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point" xmlns:ns9="http://nordu.net/namespaces/2013/12/gnsbod"><protocolVersion>application/vnd.ogf.nsi.cs.v2.requester+soap</protocolVersion><correlationId>urn:uuid:65697f03-ec46-470d-8c4a-c28739cc863e</correlationId><requesterNSA>urn:ogf:network:es.net:2013:nsa:nsi-aggr-west</requesterNSA><providerNSA>urn:ogf:network:manlan.internet2.edu</providerNSA></ns7:nsiHeader></soapenv:Header><soapenv:Body><ns2:acknowledgment xmlns:ns2="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns3="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:ns4="http://www.w3.org/2001/04/xmlenc#" xmlns:ns5="http://www.w3.org/2000/09/xmldsig#" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point" xmlns:ns9="http://nordu.net/namespaces/2013/12/gnsbod"/></soapenv:Body></soapenv:Envelope>) -
2014-06-25 20:51:44,957 DEBUG application play-akka.actor.default-dispatcher-281 - received SOAP message /nsi-v2/ConnectionServiceRequester from 198.128.14.168 with content-type Some(text/xml) <soap:Envelope xmlns:soap="http://schemas.xmlsoap.org/soap/envelope/"><soap:Header><ns7:nsiHeader xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns5="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns4="http://www.w3.org/2000/09/xmldsig#" xmlns:ns3="http://www.w3.org/2001/04/xmlenc#" xmlns:ns2="urn:oasis:names:tc:SAML:2.0:assertion"><protocolVersion>application/vdn.ogf.nsi.cs.v2.provider+soap</protocolVersion><correlationId>urn:uuid:eab6f996-484d-4181-9233-58eb33d7fa54</correlationId><requesterNSA>urn:ogf:network:es.net:2013:nsa:nsi-aggr-west</requesterNSA><providerNSA>urn:ogf:network:nsa:es.net</providerNSA><replyTo>https://oscars.es.net:8500//ConnectionService</replyTo></ns7:nsiHeader></soap:Header><soap:Body><ns5:terminateConfirmed xmlns:ns2="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:ns3="http://www.w3.org/2001/04/xmlenc#" xmlns:ns4="http://www.w3.org/2000/09/xmldsig#" xmlns:ns5="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point"><connectionId>urn:uuid:c2944c2e-c464-4c76-805d-f0f57cb7981b</connectionId></ns5:terminateConfirmed></soap:Body></soap:Envelope> -
2014-06-25 20:51:44,960 DEBUG application play-akka.actor.default-dispatcher-281 - SOAP message parse result Success([#document: null]) -
2014-06-25 20:51:44,962 DEBUG application play-internal-execution-context-1 - Received (/nsi-v2/ConnectionServiceRequester): Success(NsiRequesterMessage(NsiHeaders(urn:uuid:eab6f996-484d-4181-9233-58eb33d7fa54,urn:ogf:network:es.net:2013:nsa:nsi-aggr-west,urn:ogf:network:nsa:es.net,Some(https://oscars.es.net:8500//ConnectionService),application/vdn.ogf.nsi.cs.v2.provider+soap,List(),List()),TerminateConfirmed(urn:uuid:c2944c2e-c464-4c76-805d-f0f57cb7981b))) -
2014-06-25 20:51:44,967 DEBUG application play-akka.actor.default-dispatcher-278 - Ack 198.128.14.168 with Success(<?xml version="1.0" encoding="UTF-8" standalone="no"?><soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/"><soapenv:Header><ns7:nsiHeader xmlns:ns2="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns3="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:ns4="http://www.w3.org/2001/04/xmlenc#" xmlns:ns5="http://www.w3.org/2000/09/xmldsig#" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point" xmlns:ns9="http://nordu.net/namespaces/2013/12/gnsbod"><protocolVersion>application/vnd.ogf.nsi.cs.v2.requester+soap</protocolVersion><correlationId>urn:uuid:eab6f996-484d-4181-9233-58eb33d7fa54</correlationId><requesterNSA>urn:ogf:network:es.net:2013:nsa:nsi-aggr-west</requesterNSA><providerNSA>urn:ogf:network:nsa:es.net</providerNSA></ns7:nsiHeader></soapenv:Header><soapenv:Body><ns2:acknowledgment xmlns:ns2="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns3="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:ns4="http://www.w3.org/2001/04/xmlenc#" xmlns:ns5="http://www.w3.org/2000/09/xmldsig#" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point" xmlns:ns9="http://nordu.net/namespaces/2013/12/gnsbod"/></soapenv:Body></soapenv:Envelope>) -
2014-06-25 20:53:30,009 DEBUG application play-akka.actor.default-dispatcher-280 - received SOAP message /nsi-v2/ConnectionServiceProvider from 127.0.0.1 with content-type Some(text/xml) <soapenv:Envelope xmlns:xs="http://www.w3.org/2001/XMLSchema" xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance" xmlns:gns="http://nordu.net/namespaces/2013/12/gnsbod" xmlns:saml="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:type="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:head="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/">
<soapenv:Header>
<head:nsiHeader>
<protocolVersion>application/vnd.ogf.nsi.cs.v2.provider+soap</protocolVersion>
<correlationId>urn:uuid:c0f4778e-2892-4783-9055-74e1464e2a54</correlationId>
<requesterNSA>urn:ogf:network:es.net:2013:nsa:nsi-requester</requesterNSA>
<providerNSA>urn:ogf:network:es.net:2013:nsa:nsi-aggr-west</providerNSA>
<replyTo>https://nsi-aggr-west.es.net/requester/reply</replyTo>
</head:nsiHeader>
</soapenv:Header>
<soapenv:Body>
<type:querySummary>
<connectionId>494e60a6-db7f-4285-9e66-500289299731</connectionId>
</type:querySummary>
</soapenv:Body>
</soapenv:Envelope> -
2014-06-25 20:53:30,013 DEBUG application play-akka.actor.default-dispatcher-280 - SOAP message parse result Success([#document: null]) -
2014-06-25 20:53:30,015 DEBUG application play-internal-execution-context-1 - Received (/nsi-v2/ConnectionServiceProvider): Success(NsiProviderMessage(NsiHeaders(urn:uuid:c0f4778e-2892-4783-9055-74e1464e2a54,urn:ogf:network:es.net:2013:nsa:nsi-requester,urn:ogf:network:es.net:2013:nsa:nsi-aggr-west,Some(https://nsi-aggr-west.es.net/requester/reply),application/vnd.ogf.nsi.cs.v2.provider+soap,List(),List()),QuerySummary(Some(Left(Buffer(494e60a6-db7f-4285-9e66-500289299731)))))) -
2014-06-25 20:53:30,020 DEBUG application play-akka.actor.default-dispatcher-280 - Ack 127.0.0.1 with Success(<?xml version="1.0" encoding="UTF-8" standalone="no"?><soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/"><soapenv:Header><ns7:nsiHeader xmlns:ns2="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns3="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:ns4="http://www.w3.org/2001/04/xmlenc#" xmlns:ns5="http://www.w3.org/2000/09/xmldsig#" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point" xmlns:ns9="http://nordu.net/namespaces/2013/12/gnsbod"><protocolVersion>application/vnd.ogf.nsi.cs.v2.provider+soap</protocolVersion><correlationId>urn:uuid:c0f4778e-2892-4783-9055-74e1464e2a54</correlationId><requesterNSA>urn:ogf:network:es.net:2013:nsa:nsi-requester</requesterNSA><providerNSA>urn:ogf:network:es.net:2013:nsa:nsi-aggr-west</providerNSA></ns7:nsiHeader></soapenv:Header><soapenv:Body><ns2:acknowledgment xmlns:ns2="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns3="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:ns4="http://www.w3.org/2001/04/xmlenc#" xmlns:ns5="http://www.w3.org/2000/09/xmldsig#" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point" xmlns:ns9="http://nordu.net/namespaces/2013/12/gnsbod"/></soapenv:Body></soapenv:Envelope>) -
2014-06-25 20:53:30,024 DEBUG application play-akka.actor.default-dispatcher-289 - Sending provider urn:ogf:network:es.net:2013:nsa:nsi-requester at https://nsi-aggr-west.es.net/requester/reply the SOAP message: Success(<?xml version="1.0" encoding="UTF-8" standalone="no"?><soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/"><soapenv:Header><ns7:nsiHeader xmlns:ns2="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns3="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:ns4="http://www.w3.org/2001/04/xmlenc#" xmlns:ns5="http://www.w3.org/2000/09/xmldsig#" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point" xmlns:ns9="http://nordu.net/namespaces/2013/12/gnsbod"><protocolVersion>application/vnd.ogf.nsi.cs.v2.provider+soap</protocolVersion><correlationId>urn:uuid:c0f4778e-2892-4783-9055-74e1464e2a54</correlationId><requesterNSA>urn:ogf:network:es.net:2013:nsa:nsi-requester</requesterNSA><providerNSA>urn:ogf:network:es.net:2013:nsa:nsi-aggr-west</providerNSA></ns7:nsiHeader></soapenv:Header><soapenv:Body><ns2:querySummaryConfirmed xmlns:ns2="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:ns3="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:ns4="http://www.w3.org/2001/04/xmlenc#" xmlns:ns5="http://www.w3.org/2000/09/xmldsig#" xmlns:ns6="http://schemas.ogf.org/nsi/2013/12/framework/types" xmlns:ns7="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:ns8="http://schemas.ogf.org/nsi/2013/12/services/point2point" xmlns:ns9="http://nordu.net/namespaces/2013/12/gnsbod"><reservation><connectionId>494e60a6-db7f-4285-9e66-500289299731</connectionId><globalReservationId>urn:uuid:2888ca60-e612-11e3-ac10-0800200c9998</globalReservationId><description>Test: Terminate after end time</description><criteria version="1"><schedule><startTime>2014-06-25T20:45:00.000-07:00</startTime><endTime>2014-06-25T20:50:00.000-07:00</endTime></schedule><serviceType>http://services.ogf.org/nsi/2013/12/descriptions/EVTS.A-GOLE</serviceType><children><child order="0"><connectionId>urn:uuid:c2944c2e-c464-4c76-805d-f0f57cb7981b</connectionId><providerNSA>urn:ogf:network:es.net:2013:nsa</providerNSA><serviceType>http://services.ogf.org/nsi/2013/12/descriptions/EVTS.A-GOLE</serviceType><ns8:p2ps><capacity>100</capacity><directionality>Bidirectional</directionality><symmetricPath>true</symmetricPath><sourceSTP>urn:ogf:network:es.net:2013:ps:sunn:1?vlan=1780</sourceSTP><destSTP>urn:ogf:network:es.net:2013:manlan:aofa:1?vlan=1780</destSTP></ns8:p2ps></child><child order="1"><connectionId>urn:uuid:a46f19fa-fd4d-4bc5-ad68-390604bcf6fa</connectionId><providerNSA>urn:ogf:network:manlan.internet2.edu:2013:nsa</providerNSA><serviceType>http://services.ogf.org/nsi/2013/12/descriptions/EVTS.A-GOLE</serviceType><ns8:p2ps><capacity>100</capacity><directionality>Bidirectional</directionality><symmetricPath>true</symmetricPath><sourceSTP>urn:ogf:network:manlan.internet2.edu:2013:es?vlan=1780</sourceSTP><destSTP>urn:ogf:network:manlan.internet2.edu:2013:netherlight?vlan=1780</destSTP></ns8:p2ps></child></children><ns8:p2ps><capacity>100</capacity><directionality>Bidirectional</directionality><symmetricPath>true</symmetricPath><sourceSTP>urn:ogf:network:es.net:2013:ps:sunn:1?vlan=1780</sourceSTP><destSTP>urn:ogf:network:manlan.internet2.edu:2013:netherlight?vlan=1780</destSTP><parameter type="protection">UNPROTECTED</parameter></ns8:p2ps></criteria><requesterNSA>urn:ogf:network:es.net:2013:nsa:nsi-requester</requesterNSA><connectionStates><reservationState>ReserveStart</reservationState><provisionState>Provisioned</provisionState><lifecycleState>Terminating</lifecycleState><dataPlaneStatus><active>true</active><version>1</version><versionConsistent>true</versionConsistent></dataPlaneStatus></connectionStates></reservation></ns2:querySummaryConfirmed></soapenv:Body></soapenv:Envelope>) -
2014-06-25 20:53:30,170 DEBUG application play-akka.actor.default-dispatcher-289 - Parsing SOAP ack (200) from urn:ogf:network:es.net:2013:nsa:nsi-requester at https://nsi-aggr-west.es.net/requester/reply: <soapenv:Envelope xmlns:xs="http://www.w3.org/2001/XMLSchema" xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance" xmlns:gns="http://nordu.net/namespaces/2013/12/gnsbod" xmlns:saml="urn:oasis:names:tc:SAML:2.0:assertion" xmlns:type="http://schemas.ogf.org/nsi/2013/12/connection/types" xmlns:head="http://schemas.ogf.org/nsi/2013/12/framework/headers" xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/">
<soapenv:Header>
<head:nsiHeader>
<protocolVersion>application/vnd.ogf.nsi.cs.v2.requester+soap</protocolVersion>
<correlationId>urn:uuid:c0f4778e-2892-4783-9055-74e1464e2a54</correlationId>
<requesterNSA>urn:ogf:network:es.net:2013:nsa:nsi-requester</requesterNSA>
<providerNSA>urn:ogf:network:es.net:2013:nsa:nsi-aggr-west</providerNSA>
</head:nsiHeader>
</soapenv:Header>
<soapenv:Body>
<type:acknowledgment/>
</soapenv:Body>
</soapenv:Envelope> -
2014-06-25 20:53:30,174 DEBUG application play-akka.actor.default-dispatcher-289 - Received ack from urn:ogf:network:es.net:2013:nsa:nsi-requester at https://nsi-aggr-west.es.net/requester/reply: NsiRequesterMessage(NsiHeaders(urn:uuid:c0f4778e-2892-4783-9055-74e1464e2a54,urn:ogf:network:es.net:2013:nsa:nsi-requester,urn:ogf:network:es.net:2013:nsa:nsi-aggr-west,None,application/vnd.ogf.nsi.cs.v2.requester+soap,List(),List()),GenericAck()) -
2014-06-25 20:53:30,175 DEBUG application play-akka.actor.default-dispatcher-289 - Replying QuerySummaryConfirmed(ArrayBuffer(org.ogf.schemas.nsi._2013._12.connection.types.QuerySummaryResultType@4809337d[connectionId=494e60a6-db7f-4285-9e66-500289299731, globalReservationId=urn:uuid:2888ca60-e612-11e3-ac10-0800200c9998, description=Test: Terminate after end time, criteria={org.ogf.schemas.nsi._2013._12.connection.types.QuerySummaryResultCriteriaType@d0bb418[schedule=org.ogf.schemas.nsi._2013._12.connection.types.ScheduleType@222b993e[startTime=2014-06-25T20:45:00.000-07:00, endTime=2014-06-25T20:50:00.000-07:00], serviceType=http://services.ogf.org/nsi/2013/12/descriptions/EVTS.A-GOLE, children=org.ogf.schemas.nsi._2013._12.connection.types.ChildSummaryListType@4572b484[child={org.ogf.schemas.nsi._2013._12.connection.types.ChildSummaryType@3c4cddaf[connectionId=urn:uuid:c2944c2e-c464-4c76-805d-f0f57cb7981b, providerNSA=urn:ogf:network:es.net:2013:nsa, serviceType=http://services.ogf.org/nsi/2013/12/descriptions/EVTS.A-GOLE, any={<{http://schemas.ogf.org/nsi/2013/12/services/point2point}p2ps[org.ogf.schemas.nsi._2013._12.services.point2point.P2PServiceBaseType@522e209f[capacity=100, directionality=BIDIRECTIONAL, symmetricPath=true, sourceSTP=urn:ogf:network:es.net:2013:ps:sunn:1?vlan=1780, destSTP=urn:ogf:network:es.net:2013:manlan:aofa:1?vlan=1780, ero=<null>, parameter=<null>, any=<null>]]>}, order=0],org.ogf.schemas.nsi._2013._12.connection.types.ChildSummaryType@3ddf8380[connectionId=urn:uuid:a46f19fa-fd4d-4bc5-ad68-390604bcf6fa, providerNSA=urn:ogf:network:manlan.internet2.edu:2013:nsa, serviceType=http://services.ogf.org/nsi/2013/12/descriptions/EVTS.A-GOLE, any={<{http://schemas.ogf.org/nsi/2013/12/services/point2point}p2ps[org.ogf.schemas.nsi._2013._12.services.point2point.P2PServiceBaseType@1bf6bed2[capacity=100, directionality=BIDIRECTIONAL, symmetricPath=true, sourceSTP=urn:ogf:network:manlan.internet2.edu:2013:es?vlan=1780, destSTP=urn:ogf:network:manlan.internet2.edu:2013:netherlight?vlan=1780, ero=<null>, parameter=<null>, any=<null>]]>}, order=1]}], any={<{http://schemas.ogf.org/nsi/2013/12/services/point2point}p2ps[org.ogf.schemas.nsi._2013._12.services.point2point.P2PServiceBaseType@2cd2ec3f[capacity=100, directionality=BIDIRECTIONAL, symmetricPath=true, sourceSTP=urn:ogf:network:es.net:2013:ps:sunn:1?vlan=1780, destSTP=urn:ogf:network:manlan.internet2.edu:2013:netherlight?vlan=1780, ero=<null>, parameter={org.ogf.schemas.nsi._2013._12.services.types.TypeValueType@692fae4a[value=UNPROTECTED, type=protection]}, any=<null>]]>}, version=1]}, requesterNSA=urn:ogf:network:es.net:2013:nsa:nsi-requester, connectionStates=org.ogf.schemas.nsi._2013._12.connection.types.ConnectionStatesType@6d244b57[reservationState=RESERVE_START, provisionState=PROVISIONED, lifecycleState=TERMINATING, dataPlaneStatus=org.ogf.schemas.nsi._2013._12.connection.types.DataPlaneStatusType@3d2214e3[active=true, version=1, versionConsistent=true]], notificationId=<null>, resultId=<null>])) to https://nsi-aggr-west.es.net/requester/reply succeeded with NsiRequesterMessage(NsiHeaders(urn:uuid:c0f4778e-2892-4783-9055-74e1464e2a54,urn:ogf:network:es.net:2013:nsa:nsi-requester,urn:ogf:network:es.net:2013:nsa:nsi-aggr-west,None,application/vnd.ogf.nsi.cs.v2.requester+soap,List(),List()),GenericAck()) -
The terminate request did not update the child connections when the connection was in PassedEndTime. So when a terminateConfirmed was received for a child connection it did not update the LSM of the child connection. And thus never changed the LSM of the connection to Terminated which sends the TerminateConfirmed to the requester.
Discovered that Safnari is not sending a terminate confirm up to the requester after it receives the final terminate confirmation. They are also not making it into the message log when looking at the connection. I am able to reproduce this by sending down a terminate request at any point after end time.
The parent connection says it is in the terminating state as seen here:
Here is the image of the connection table saying the children are not terminated:
You can see that the LSM is in a created state for both child connections. In this test case I sent the terminate after the reservation end time. The message flow from #31 onwards shows the terminate message sequence. The Safnari logs indicate that the two child reserveConfirm messages were received, but nothing else seems to happen. Log is attached for message sequence (at least I will try to attach the logs).
Messages