You are viewing a plain text version of this content. The canonical link for it is here.
Posted to builds@mesos.apache.org by Apache Jenkins Server <je...@builds.apache.org> on 2017/11/11 06:49:19 UTC
Build failed in Jenkins: Mesos-Buildbot » cmake,clang,--verbose --disable-libtool-wrappers,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)&&(!qnode3)&&(!H23) #4445
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=cmake,COMPILER=clang,CONFIGURATION=--verbose%20--disable-libtool-wrappers,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)&&(!qnode3)&&(!H23)/4445/display/redirect>
------------------------------------------
[...truncated 18.76 MB...]
3: I1111 06:49:12.706764 15905 master.cpp:3042] Subscribing framework default with checkpointing disabled and capabilities [ RESERVATION_REFINEMENT ]
3: I1111 06:49:12.706780 15903 slave.cpp:6422] Finished recovery
3: I1111 06:49:12.707358 15912 sched.cpp:751] Framework registered with fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-0000
3: I1111 06:49:12.707423 15908 slave.cpp:1007] New master detected at master@172.17.0.3:55548
3: I1111 06:49:12.707432 15911 status_update_manager.cpp:177] Pausing sending status updates
3: I1111 06:49:12.707473 15902 hierarchical.cpp:303] Added framework fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-0000
3: I1111 06:49:12.707442 15912 sched.cpp:765] Scheduler::registered took 66697ns
3: I1111 06:49:12.707538 15908 slave.cpp:1042] Detecting new master
3: I1111 06:49:12.707881 15902 hierarchical.cpp:1450] Performed allocation for 0 agents in 87698ns
3: I1111 06:49:12.709789 15903 slave.cpp:1069] Authenticating with master master@172.17.0.3:55548
3: I1111 06:49:12.709841 15903 slave.cpp:1078] Using default CRAM-MD5 authenticatee
3: I1111 06:49:12.710012 15916 authenticatee.cpp:121] Creating new client SASL connection
3: I1111 06:49:12.710239 15917 master.cpp:8286] Authenticating slave(484)@172.17.0.3:55548
3: I1111 06:49:12.710320 15913 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(990)@172.17.0.3:55548
3: I1111 06:49:12.710494 15911 authenticator.cpp:98] Creating new server SASL connection
3: I1111 06:49:12.710659 15907 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
3: I1111 06:49:12.710681 15907 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
3: I1111 06:49:12.710773 15907 authenticator.cpp:204] Received SASL authentication start
3: I1111 06:49:12.710816 15907 authenticator.cpp:326] Authentication requires more steps
3: I1111 06:49:12.710916 15915 authenticatee.cpp:259] Received SASL authentication step
3: I1111 06:49:12.711087 15914 authenticator.cpp:232] Received SASL authentication step
3: I1111 06:49:12.711110 15914 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '5db355fcacb6' server FQDN: '5db355fcacb6' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
3: I1111 06:49:12.711122 15914 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
3: I1111 06:49:12.711153 15914 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
3: I1111 06:49:12.711184 15914 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '5db355fcacb6' server FQDN: '5db355fcacb6' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
3: I1111 06:49:12.711200 15914 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
3: I1111 06:49:12.711205 15914 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
3: I1111 06:49:12.711220 15914 authenticator.cpp:318] Authentication success
3: I1111 06:49:12.711289 15909 authenticatee.cpp:299] Authentication success
3: I1111 06:49:12.711377 15906 master.cpp:8316] Successfully authenticated principal 'test-principal' at slave(484)@172.17.0.3:55548
3: I1111 06:49:12.711411 15904 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(990)@172.17.0.3:55548
3: I1111 06:49:12.711611 15908 slave.cpp:1161] Successfully authenticated with master master@172.17.0.3:55548
3: I1111 06:49:12.711819 15908 slave.cpp:1682] Will retry registration in 4.093185ms if necessary
3: I1111 06:49:12.711994 15903 master.cpp:6033] Received register agent message from slave(484)@172.17.0.3:55548 (5db355fcacb6)
3: I1111 06:49:12.712025 15903 master.cpp:3871] Authorizing agent with principal 'test-principal'
3: I1111 06:49:12.712321 15903 master.cpp:6093] Authorized registration of agent at slave(484)@172.17.0.3:55548 (5db355fcacb6)
3: I1111 06:49:12.712419 15903 master.cpp:6186] Registering agent at slave(484)@172.17.0.3:55548 (5db355fcacb6) with id fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-S0
3: I1111 06:49:12.712762 15913 registrar.cpp:495] Applied 1 operations in 63201ns; attempting to update the registry
3: I1111 06:49:12.713235 15913 registrar.cpp:552] Successfully updated the registry in 428032ns
3: I1111 06:49:12.713400 15909 master.cpp:6233] Admitted agent fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-S0 at slave(484)@172.17.0.3:55548 (5db355fcacb6)
3: I1111 06:49:12.713949 15902 slave.cpp:1207] Registered with master master@172.17.0.3:55548; given agent ID fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-S0
3: I1111 06:49:12.714066 15910 status_update_manager.cpp:184] Resuming sending status updates
3: I1111 06:49:12.713881 15909 master.cpp:6264] Registered agent fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-S0 at slave(484)@172.17.0.3:55548 (5db355fcacb6) with [{"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}]
3: I1111 06:49:12.714337 15905 hierarchical.cpp:593] Added agent fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-S0 (5db355fcacb6) with cpus:2; mem:1024; disk:1024; ports:[31000-32000] (allocated: {})
3: I1111 06:49:12.714355 15902 slave.cpp:1227] Checkpointing SlaveInfo to '/tmp/ReconciliationTest_TaskStateMatch_YyZ5Ar/meta/slaves/fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-S0/slave.info'
3: I1111 06:49:12.714743 15902 slave.cpp:1295] Forwarding total oversubscribed resources {}
3: I1111 06:49:12.714933 15904 master.cpp:7065] Received update of agent fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-S0 at slave(484)@172.17.0.3:55548 (5db355fcacb6) with total oversubscribed resources {}
3: I1111 06:49:12.715164 15904 master.cpp:7083] Ignoring update on agent fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-S0 at slave(484)@172.17.0.3:55548 (5db355fcacb6) as it reports no changes
3: I1111 06:49:12.715420 15905 hierarchical.cpp:1450] Performed allocation for 1 agents in 955847ns
3: I1111 06:49:12.715831 15908 master.cpp:8116] Sending 1 offers to framework fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-0000 (default) at scheduler-08f13b73-13ad-4ce5-b58b-df757a626bad@172.17.0.3:55548
3: I1111 06:49:12.716847 15916 sched.cpp:921] Scheduler::resourceOffers took 666694ns
3: I1111 06:49:12.717882 15917 master.cpp:10016] Removing offer fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-O0
3: I1111 06:49:12.718010 15917 master.cpp:4229] Processing ACCEPT call for offers: [ fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-O0 ] on agent fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-S0 at slave(484)@172.17.0.3:55548 (5db355fcacb6) for framework fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-0000 (default) at scheduler-08f13b73-13ad-4ce5-b58b-df757a626bad@172.17.0.3:55548
3: I1111 06:49:12.718089 15917 master.cpp:3598] Authorizing framework principal 'test-principal' to launch task 0
3: W1111 06:49:12.719593 15917 validation.cpp:1404] Executor 'default' for task '0' uses less CPUs (None) than the minimum required (0.01). Please update your executor, as this will be mandatory in future releases.
3: W1111 06:49:12.719617 15917 validation.cpp:1416] Executor 'default' for task '0' uses less memory (None) than the minimum required (32MB). Please update your executor, as this will be mandatory in future releases.
3: I1111 06:49:12.719934 15917 master.cpp:10762] Adding task 0 with resources [{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":1.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":512.0},"type":"SCALAR"}] on agent fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-S0 at slave(484)@172.17.0.3:55548 (5db355fcacb6)
3: I1111 06:49:12.720218 15917 master.cpp:4977] Launching task 0 of framework fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-0000 (default) at scheduler-08f13b73-13ad-4ce5-b58b-df757a626bad@172.17.0.3:55548 with resources [{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":1.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":512.0},"type":"SCALAR"}] on agent fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-S0 at slave(484)@172.17.0.3:55548 (5db355fcacb6)
3: I1111 06:49:12.720657 15915 slave.cpp:1803] Got assigned task '0' for framework fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-0000
3: I1111 06:49:12.721189 15913 hierarchical.cpp:1125] Recovered cpus(allocated: *):1; mem(allocated: *):512; disk(allocated: *):1024; ports(allocated: *):[31000-32000] (total: cpus:2; mem:1024; disk:1024; ports:[31000-32000], allocated: cpus(allocated: *):1; mem(allocated: *):512) on agent fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-S0 from framework fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-0000
3: I1111 06:49:12.721242 15915 slave.cpp:2071] Authorizing task '0' for framework fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-0000
3: I1111 06:49:12.721246 15913 hierarchical.cpp:1171] Framework fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-0000 filtered agent fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-S0 for 5secs
3: I1111 06:49:12.721308 15915 slave.cpp:7030] Authorizing framework principal 'test-principal' to launch task 0
3: I1111 06:49:12.721977 15909 slave.cpp:2239] Launching task '0' for framework fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-0000
3: I1111 06:49:12.722510 15909 paths.cpp:605] Trying to chown '/tmp/ReconciliationTest_TaskStateMatch_YyZ5Ar/slaves/fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-S0/frameworks/fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-0000/executors/default/runs/a65f62b5-5f21-491c-b6b3-ed77167a443c' to user 'mesos'
3: I1111 06:49:12.722705 15909 slave.cpp:7504] Launching executor 'default' of framework fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-0000 with resources [] in work directory '/tmp/ReconciliationTest_TaskStateMatch_YyZ5Ar/slaves/fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-S0/frameworks/fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-0000/executors/default/runs/a65f62b5-5f21-491c-b6b3-ed77167a443c'
3: I1111 06:49:12.723074 15909 slave.cpp:2930] Launching container a65f62b5-5f21-491c-b6b3-ed77167a443c for executor 'default' of framework fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-0000
3: I1111 06:49:12.723326 15909 slave.cpp:2467] Queued task '0' for executor 'default' of framework fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-0000
3: I1111 06:49:12.723395 15909 slave.cpp:958] Successfully attached '/tmp/ReconciliationTest_TaskStateMatch_YyZ5Ar/slaves/fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-S0/frameworks/fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-0000/executors/default/runs/a65f62b5-5f21-491c-b6b3-ed77167a443c' to virtual path '/tmp/ReconciliationTest_TaskStateMatch_YyZ5Ar/slaves/fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-S0/frameworks/fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-0000/executors/default/runs/latest'
3: I1111 06:49:12.723426 15909 slave.cpp:958] Successfully attached '/tmp/ReconciliationTest_TaskStateMatch_YyZ5Ar/slaves/fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-S0/frameworks/fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-0000/executors/default/runs/a65f62b5-5f21-491c-b6b3-ed77167a443c' to virtual path '/frameworks/fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-0000/executors/default/runs/latest'
3: I1111 06:49:12.723450 15909 slave.cpp:958] Successfully attached '/tmp/ReconciliationTest_TaskStateMatch_YyZ5Ar/slaves/fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-S0/frameworks/fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-0000/executors/default/runs/a65f62b5-5f21-491c-b6b3-ed77167a443c' to virtual path '/tmp/ReconciliationTest_TaskStateMatch_YyZ5Ar/slaves/fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-S0/frameworks/fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-0000/executors/default/runs/a65f62b5-5f21-491c-b6b3-ed77167a443c'
3: W1111 06:49:12.725226 15905 process.cpp:3178] Attempted to spawn already running process version@172.17.0.3:55548
3: I1111 06:49:12.725378 15905 exec.cpp:162] Version: 1.5.0
3: I1111 06:49:12.725603 15916 exec.cpp:212] Executor started at: executor(166)@172.17.0.3:55548 with pid 15901
3: I1111 06:49:12.725795 15912 slave.cpp:4053] Got registration for executor 'default' of framework fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-0000 from executor(166)@172.17.0.3:55548
3: I1111 06:49:12.726156 15903 exec.cpp:237] Executor registered on agent fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-S0
3: I1111 06:49:12.726213 15903 exec.cpp:249] Executor::registered took 54362ns
3: I1111 06:49:12.726636 15912 slave.cpp:2669] Sending queued task '0' to executor 'default' of framework fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-0000 at executor(166)@172.17.0.3:55548
3: I1111 06:49:12.726924 15917 exec.cpp:331] Executor asked to run task '0'
3: I1111 06:49:12.726994 15917 exec.cpp:340] Executor::launchTask took 60375ns
3: I1111 06:49:12.727082 15917 exec.cpp:571] Executor sending status update TASK_RUNNING (UUID: d6b2150e-3a1b-4275-9349-2aa3687cb1b1) for task 0 of framework fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-0000
3: I1111 06:49:12.727335 15913 slave.cpp:4507] Handling status update TASK_RUNNING (UUID: d6b2150e-3a1b-4275-9349-2aa3687cb1b1) for task 0 of framework fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-0000 from executor(166)@172.17.0.3:55548
3: I1111 06:49:12.727784 15915 status_update_manager.cpp:323] Received status update TASK_RUNNING (UUID: d6b2150e-3a1b-4275-9349-2aa3687cb1b1) for task 0 of framework fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-0000
3: I1111 06:49:12.727819 15915 status_update_manager.cpp:500] Creating StatusUpdate stream for task 0 of framework fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-0000
3: I1111 06:49:12.728194 15915 status_update_manager.cpp:377] Forwarding update TASK_RUNNING (UUID: d6b2150e-3a1b-4275-9349-2aa3687cb1b1) for task 0 of framework fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-0000 to the agent
3: I1111 06:49:12.728377 15914 slave.cpp:4988] Forwarding the update TASK_RUNNING (UUID: d6b2150e-3a1b-4275-9349-2aa3687cb1b1) for task 0 of framework fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-0000 to master@172.17.0.3:55548
3: I1111 06:49:12.728559 15914 slave.cpp:4882] Status update manager successfully handled status update TASK_RUNNING (UUID: d6b2150e-3a1b-4275-9349-2aa3687cb1b1) for task 0 of framework fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-0000
3: I1111 06:49:12.728607 15914 slave.cpp:4898] Sending acknowledgement for status update TASK_RUNNING (UUID: d6b2150e-3a1b-4275-9349-2aa3687cb1b1) for task 0 of framework fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-0000 to executor(166)@172.17.0.3:55548
3: I1111 06:49:12.728716 15910 master.cpp:7248] Status update TASK_RUNNING (UUID: d6b2150e-3a1b-4275-9349-2aa3687cb1b1) for task 0 of framework fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-0000 from agent fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-S0 at slave(484)@172.17.0.3:55548 (5db355fcacb6)
3: I1111 06:49:12.728765 15910 master.cpp:7310] Forwarding status update TASK_RUNNING (UUID: d6b2150e-3a1b-4275-9349-2aa3687cb1b1) for task 0 of framework fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-0000
3: I1111 06:49:12.728790 15902 exec.cpp:388] Executor received status update acknowledgement d6b2150e-3a1b-4275-9349-2aa3687cb1b1 for task 0 of framework fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-0000
3: I1111 06:49:12.728945 15910 master.cpp:9503] Updating the state of task 0 of framework fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-0000 (latest state: TASK_RUNNING, status update state: TASK_RUNNING)
3: I1111 06:49:12.729259 15904 sched.cpp:1029] Scheduler::statusUpdate took 146551ns
3: I1111 06:49:12.729595 15916 master.cpp:5792] Processing ACKNOWLEDGE call d6b2150e-3a1b-4275-9349-2aa3687cb1b1 for task 0 of framework fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-0000 (default) at scheduler-08f13b73-13ad-4ce5-b58b-df757a626bad@172.17.0.3:55548 on agent fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-S0
3: I1111 06:49:12.729856 15906 status_update_manager.cpp:395] Received status update acknowledgement (UUID: d6b2150e-3a1b-4275-9349-2aa3687cb1b1) for task 0 of framework fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-0000
3: I1111 06:49:12.729854 15916 master.cpp:7770] Performing explicit task state reconciliation for 1 tasks of framework fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-0000 (default) at scheduler-08f13b73-13ad-4ce5-b58b-df757a626bad@172.17.0.3:55548
3: I1111 06:49:12.729980 15916 master.cpp:7918] Sending explicit reconciliation state TASK_RUNNING for task 0 of framework fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-0000 (default) at scheduler-08f13b73-13ad-4ce5-b58b-df757a626bad@172.17.0.3:55548
3: I1111 06:49:12.730098 15913 slave.cpp:3791] Status update manager successfully handled status update acknowledgement (UUID: d6b2150e-3a1b-4275-9349-2aa3687cb1b1) for task 0 of framework fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-0000
3: I1111 06:49:12.730301 15915 sched.cpp:1029] Scheduler::statusUpdate took 77430ns
3: I1111 06:49:12.730525 15901 sched.cpp:2009] Asked to stop the driver
3: I1111 06:49:12.730598 15909 sched.cpp:1191] Stopping framework fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-0000
3: I1111 06:49:12.730813 15905 master.cpp:8793] Processing TEARDOWN call for framework fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-0000 (default) at scheduler-08f13b73-13ad-4ce5-b58b-df757a626bad@172.17.0.3:55548
3: I1111 06:49:12.730841 15905 master.cpp:8805] Removing framework fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-0000 (default) at scheduler-08f13b73-13ad-4ce5-b58b-df757a626bad@172.17.0.3:55548
3: I1111 06:49:12.730852 15905 master.cpp:3332] Deactivating framework fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-0000 (default) at scheduler-08f13b73-13ad-4ce5-b58b-df757a626bad@172.17.0.3:55548
3: I1111 06:49:12.730968 15917 hierarchical.cpp:412] Deactivated framework fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-0000
3: I1111 06:49:12.731012 15905 master.cpp:9503] Updating the state of task 0 of framework fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-0000 (latest state: TASK_KILLED, status update state: TASK_KILLED)
3: I1111 06:49:12.731029 15907 slave.cpp:3267] Asked to shut down framework fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-0000 by master@172.17.0.3:55548
3: I1111 06:49:12.731081 15907 slave.cpp:3292] Shutting down framework fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-0000
3: I1111 06:49:12.731238 15907 slave.cpp:5855] Shutting down executor 'default' of framework fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-0000 at executor(166)@172.17.0.3:55548
3: I1111 06:49:12.731410 15907 exec.cpp:435] Executor asked to shutdown
3: I1111 06:49:12.731443 15907 exec.cpp:450] Executor::shutdown took 24218ns
3: I1111 06:49:12.731600 15905 master.cpp:9597] Removing task 0 with resources [{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":1.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":512.0},"type":"SCALAR"}] of framework fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-0000 on agent fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-S0 at slave(484)@172.17.0.3:55548 (5db355fcacb6)
3: I1111 06:49:12.731828 15911 slave.cpp:5120] Got exited event for executor(166)@172.17.0.3:55548
3: I1111 06:49:12.731986 15916 hierarchical.cpp:1125] Recovered cpus(allocated: *):1; mem(allocated: *):512 (total: cpus:2; mem:1024; disk:1024; ports:[31000-32000], allocated: {}) on agent fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-S0 from framework fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-0000
3: I1111 06:49:12.732035 15905 master.cpp:9626] Removing executor 'default' with resources [] of framework fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-0000 on agent fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-S0 at slave(484)@172.17.0.3:55548 (5db355fcacb6)
3: I1111 06:49:12.732241 15912 slave.cpp:5520] Executor 'default' of framework fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-0000 exited with status 0
3: I1111 06:49:12.732311 15912 slave.cpp:5624] Cleaning up executor 'default' of framework fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-0000 at executor(166)@172.17.0.3:55548
3: W1111 06:49:12.732697 15905 master.cpp:7454] Ignoring unknown exited executor 'default' of framework fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-0000 on agent fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-S0 at slave(484)@172.17.0.3:55548 (5db355fcacb6)
3: I1111 06:49:12.732905 15907 gc.cpp:90] Scheduling '/tmp/ReconciliationTest_TaskStateMatch_YyZ5Ar/slaves/fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-S0/frameworks/fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-0000/executors/default/runs/a65f62b5-5f21-491c-b6b3-ed77167a443c' for gc 6.99999151887704days in the future
3: I1111 06:49:12.732965 15908 hierarchical.cpp:355] Removed framework fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-0000
3: I1111 06:49:12.733072 15912 slave.cpp:5731] Cleaning up framework fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-0000
3: I1111 06:49:12.733088 15907 gc.cpp:90] Scheduling '/tmp/ReconciliationTest_TaskStateMatch_YyZ5Ar/slaves/fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-S0/frameworks/fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-0000/executors/default' for gc 6.99999151619259days in the future
3: I1111 06:49:12.733160 15915 status_update_manager.cpp:285] Closing status update streams for framework fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-0000
3: I1111 06:49:12.733202 15915 status_update_manager.cpp:531] Cleaning up status update stream for task 0 of framework fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-0000
3: I1111 06:49:12.733255 15912 slave.cpp:883] Agent terminating
3: I1111 06:49:12.733260 15902 gc.cpp:90] Scheduling '/tmp/ReconciliationTest_TaskStateMatch_YyZ5Ar/slaves/fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-S0/frameworks/fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-0000' for gc 6.99999151420148days in the future
3: I1111 06:49:12.733405 15911 master.cpp:1309] Agent fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-S0 at slave(484)@172.17.0.3:55548 (5db355fcacb6) disconnected
3: I1111 06:49:12.733423 15911 master.cpp:3369] Disconnecting agent fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-S0 at slave(484)@172.17.0.3:55548 (5db355fcacb6)
3: I1111 06:49:12.733475 15911 master.cpp:3388] Deactivating agent fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-S0 at slave(484)@172.17.0.3:55548 (5db355fcacb6)
3: I1111 06:49:12.733597 15906 hierarchical.cpp:690] Agent fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-S0 deactivated
3: I1111 06:49:12.736253 15901 master.cpp:1151] Master terminating
3: I1111 06:49:12.736799 15911 hierarchical.cpp:626] Removed agent fd85aeca-bcca-42fb-9ddc-0ed03ee2b1c6-S0
3: [ OK ] ReconciliationTest.TaskStateMatch (54 ms)
3: [ RUN ] ReconciliationTest.UnknownSlave
3: I1111 06:49:12.742236 15901 cluster.cpp:162] Creating default 'local' authorizer
3: I1111 06:49:12.744545 15908 master.cpp:448] Master f2d98912-ff40-45b0-99b0-c51af34a0b0b (5db355fcacb6) started on 172.17.0.3:55548
3: I1111 06:49:12.744576 15908 master.cpp:450] Flags at startup: --acls="" --agent_ping_timeout="15secs" --agent_reregister_timeout="10mins" --allocation_interval="1secs" --allocator="HierarchicalDRF" --authenticate_agents="true" --authenticate_frameworks="true" --authenticate_http_frameworks="true" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticators="crammd5" --authorizers="local" --credentials="/tmp/EK984A/credentials" --filter_gpu_resources="true" --framework_sorter="drf" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_framework_authenticators="basic" --initialize_driver_logging="true" --log_auto_initialize="true" --logbufsecs="0" --logging_level="INFO" --max_agent_ping_timeouts="5" --max_completed_frameworks="50" --max_completed_tasks_per_framework="1000" --max_unreachable_tasks_per_framework="1000" --port="5050" --quiet="false" --recovery_agent_removal_limit="100%" --registry="in_memory" --registry_fetch_timeout="1mins" --registry_gc_interval="15mins" --registry_max_agent_age="2weeks" --registry_max_agent_count="102400" --registry_store_timeout="100secs" --registry_strict="false" --root_submissions="true" --user_sorter="drf" --version="false" --webui_dir="/usr/local/share/mesos/webui" --work_dir="/tmp/EK984A/master" --zk_session_timeout="10secs"
3: I1111 06:49:12.744861 15908 master.cpp:499] Master only allowing authenticated frameworks to register
3: I1111 06:49:12.744869 15908 master.cpp:505] Master only allowing authenticated agents to register
3: I1111 06:49:12.744874 15908 master.cpp:511] Master only allowing authenticated HTTP frameworks to register
3: I1111 06:49:12.744879 15908 credentials.hpp:37] Loading credentials for authentication from '/tmp/EK984A/credentials'
3: I1111 06:49:12.745120 15908 master.cpp:555] Using default 'crammd5' authenticator
3: I1111 06:49:12.745244 15908 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readonly'
3: I1111 06:49:12.745375 15908 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readwrite'
3: I1111 06:49:12.745479 15908 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-master-scheduler'
3: I1111 06:49:12.745576 15908 master.cpp:634] Authorization enabled
3: I1111 06:49:12.745707 15914 hierarchical.cpp:171] Initialized hierarchical allocator process
3: I1111 06:49:12.745723 15917 whitelist_watcher.cpp:77] No whitelist given
3: I1111 06:49:12.747978 15912 master.cpp:2213] Elected as the leading master!
3: I1111 06:49:12.747997 15912 master.cpp:1693] Recovering from registrar
3: I1111 06:49:12.748101 15909 registrar.cpp:347] Recovering registrar
3: I1111 06:49:12.748594 15909 registrar.cpp:391] Successfully fetched the registry (0B) in 465152ns
3: I1111 06:49:12.748697 15909 registrar.cpp:495] Applied 1 operations in 38304ns; attempting to update the registry
3: I1111 06:49:12.749166 15909 registrar.cpp:552] Successfully updated the registry in 419072ns
3: I1111 06:49:12.749260 15909 registrar.cpp:424] Successfully recovered registrar
3: I1111 06:49:12.749632 15904 hierarchical.cpp:209] Skipping recovery of hierarchical allocator: nothing to recover
3: I1111 06:49:12.749625 15915 master.cpp:1806] Recovered 0 agents from the registry (129B); allowing 10mins for agents to re-register
3: W1111 06:49:12.750275 15901 process.cpp:3178] Attempted to spawn already running process version@172.17.0.3:55548
3: I1111 06:49:12.751037 15901 sched.cpp:232] Version: 1.5.0
3: I1111 06:49:12.751485 15905 sched.cpp:336] New master detected at master@172.17.0.3:55548
3: I1111 06:49:12.751567 15905 sched.cpp:396] Authenticating with master master@172.17.0.3:55548
3: I1111 06:49:12.751585 15905 sched.cpp:403] Using default CRAM-MD5 authenticatee
3: I1111 06:49:12.751842 15906 authenticatee.cpp:121] Creating new client SASL connection
3: I1111 06:49:12.752073 15908 master.cpp:8286] Authenticating scheduler-ef6d7a6b-db19-4539-89da-803ffac92a99@172.17.0.3:55548
3: I1111 06:49:12.752199 15914 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(991)@172.17.0.3:55548
3: I1111 06:49:12.752408 15912 authenticator.cpp:98] Creating new server SASL connection
3: I1111 06:49:12.752604 15903 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
3: I1111 06:49:12.752629 15903 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
3: I1111 06:49:12.752735 15904 authenticator.cpp:204] Received SASL authentication start
3: I1111 06:49:12.752791 15904 authenticator.cpp:326] Authentication requires more steps
3: I1111 06:49:12.752899 15915 authenticatee.cpp:259] Received SASL authentication step
3: I1111 06:49:12.753010 15911 authenticator.cpp:232] Received SASL authentication step
3: I1111 06:49:12.753039 15911 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '5db355fcacb6' server FQDN: '5db355fcacb6' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
3: I1111 06:49:12.753056 15911 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
3: I1111 06:49:12.753098 15911 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
3: I1111 06:49:12.753127 15911 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '5db355fcacb6' server FQDN: '5db355fcacb6' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
3: I1111 06:49:12.753141 15911 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
3: I1111 06:49:12.753149 15911 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
3: I1111 06:49:12.753167 15911 authenticator.cpp:318] Authentication success
3: I1111 06:49:12.753293 15916 authenticatee.cpp:299] Authentication success
3: I1111 06:49:12.753316 15907 master.cpp:8316] Successfully authenticated principal 'test-principal' at scheduler-ef6d7a6b-db19-4539-89da-803ffac92a99@172.17.0.3:55548
3: I1111 06:49:12.753338 15911 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(991)@172.17.0.3:55548
3: I1111 06:49:12.753595 15913 sched.cpp:502] Successfully authenticated with master master@172.17.0.3:55548
3: I1111 06:49:12.753612 15913 sched.cpp:824] Sending SUBSCRIBE call to master@172.17.0.3:55548
3: I1111 06:49:12.753710 15913 sched.cpp:857] Will retry registration in 1.053289839secs if necessary
3: I1111 06:49:12.753855 15906 master.cpp:2962] Received SUBSCRIBE call for framework 'default' at scheduler-ef6d7a6b-db19-4539-89da-803ffac92a99@172.17.0.3:55548
3: I1111 06:49:12.753875 15906 master.cpp:2278] Authorizing framework principal 'test-principal' to receive offers for roles '{ * }'
3: I1111 06:49:12.754290 15914 master.cpp:3042] Subscribing framework default with checkpointing disabled and capabilities [ RESERVATION_REFINEMENT, PARTITION_AWARE ]
3: I1111 06:49:12.754788 15904 sched.cpp:751] Framework registered with f2d98912-ff40-45b0-99b0-c51af34a0b0b-0000
3: I1111 06:49:12.754866 15904 sched.cpp:765] Scheduler::registered took 63643ns
3: I1111 06:49:12.755044 15912 hierarchical.cpp:303] Added framework f2d98912-ff40-45b0-99b0-c51af34a0b0b-0000
3: I1111 06:49:12.755216 15912 hierarchical.cpp:1450] Performed allocation for 0 agents in 75718ns
3: I1111 06:49:12.755467 15913 master.cpp:7770] Performing explicit task state reconciliation for 1 tasks of framework f2d98912-ff40-45b0-99b0-c51af34a0b0b-0000 (default) at scheduler-ef6d7a6b-db19-4539-89da-803ffac92a99@172.17.0.3:55548
3: I1111 06:49:12.755586 15913 master.cpp:7918] Sending explicit reconciliation state TASK_UNKNOWN for task d8995d84-c5c5-40d4-94dc-8efd3d6370ec of framework f2d98912-ff40-45b0-99b0-c51af34a0b0b-0000 (default) at scheduler-ef6d7a6b-db19-4539-89da-803ffac92a99@172.17.0.3:55548
3: I1111 06:49:12.755861 15906 sched.cpp:1029] Scheduler::statusUpdate took 55803ns
3: I1111 06:49:12.756043 15901 sched.cpp:2009] Asked to stop the driver
3: I1111 06:49:12.756114 15916 sched.cpp:1191] Stopping framework f2d98912-ff40-45b0-99b0-c51af34a0b0b-0000
3: I1111 06:49:12.756305 15904 master.cpp:8793] Processing TEARDOWN call for framework f2d98912-ff40-45b0-99b0-c51af34a0b0b-0000 (default) at scheduler-ef6d7a6b-db19-4539-89da-803ffac92a99@172.17.0.3:55548
3: I1111 06:49:12.756335 15904 master.cpp:8805] Removing framework f2d98912-ff40-45b0-99b0-c51af34a0b0b-0000 (default) at scheduler-ef6d7a6b-db19-4539-89da-803ffac92a99@172.17.0.3:55548
3: I1111 06:49:12.756356 15904 master.cpp:3332] Deactivating framework f2d98912-ff40-45b0-99b0-c51af34a0b0b-0000 (default) at scheduler-ef6d7a6b-db19-4539-89da-803ffac92a99@172.17.0.3:55548
3: I1111 06:49:12.756491 15902 hierarchical.cpp:412] Deactivated framework f2d98912-ff40-45b0-99b0-c51af34a0b0b-0000
3: I1111 06:49:12.756825 15911 hierarchical.cpp:355] Removed framework f2d98912-ff40-45b0-99b0-c51af34a0b0b-0000
3: I1111 06:49:12.756872 15914 master.cpp:1151] Master terminating
3: [ OK ] ReconciliationTest.UnknownSlave (19 ms)
3: [ RUN ] ReconciliationTest.UnknownTask
3: I1111 06:49:12.761786 15901 cluster.cpp:162] Creating default 'local' authorizer
3: I1111 06:49:12.765663 15905 master.cpp:448] Master 5e6a9856-9289-41bd-b6be-05872487a116 (5db355fcacb6) started on 172.17.0.3:55548
3: I1111 06:49:12.765707 15905 master.cpp:450] Flags at startup: --acls="" --agent_ping_timeout="15secs" --agent_reregister_timeout="10mins" --allocation_interval="1secs" --allocator="HierarchicalDRF" --authenticate_agents="true" --authenticate_frameworks="true" --authenticate_http_frameworks="true" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticators="crammd5" --authorizers="local" --credentials="/tmp/zWjqz8/credentials" --filter_gpu_resources="true" --framework_sorter="drf" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_framework_authenticators="basic" --initialize_driver_logging="true" --log_auto_initialize="true" --logbufsecs="0" --logging_level="INFO" --max_agent_ping_timeouts="5" --max_completed_frameworks="50" --max_completed_tasks_per_framework="1000" --max_unreachable_tasks_per_framework="1000" --port="5050" --quiet="false" --recovery_agent_removal_limit="100%" --registry="in_memory" --registry_fetch_timeout="1mins" --registry_gc_interval="15mins" --registry_max_agent_age="2weeks" --registry_max_agent_count="102400" --registry_store_timeout="100secs" --registry_strict="false" --root_submissions="true" --user_sorter="drf" --version="false" --webui_dir="/usr/local/share/mesos/webui" --work_dir="/tmp/zWjqz8/master" --zk_session_timeout="10secs"
3: I1111 06:49:12.766018 15905 master.cpp:499] Master only allowing authenticated frameworks to register
3: I1111 06:49:12.766027 15905 master.cpp:505] Master only allowing authenticated agents to register
3: I1111 06:49:12.766037 15905 master.cpp:511] Master only allowing authenticated HTTP frameworks to register
3: I1111 06:49:12.766047 15905 credentials.hpp:37] Loading credentials for authentication from '/tmp/zWjqz8/credentials'
3: I1111 06:49:12.766311 15905 master.cpp:555] Using default 'crammd5' authenticator
3: I1111 06:49:12.766433 15905 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readonly'
3: I1111 06:49:12.766588 15905 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readwrite'
3: I1111 06:49:12.766712 15905 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-master-scheduler'
3: I1111 06:49:12.766841 15905 master.cpp:634] Authorization enabled
3: I1111 06:49:12.766983 15909 hierarchical.cpp:171] Initialized hierarchical allocator process
3: I1111 06:49:12.767024 15906 whitelist_watcher.cpp:77] No whitelist given
3: I1111 06:49:12.769215 15916 master.cpp:2213] Elected as the leading master!
3: I1111 06:49:12.769233 15916 master.cpp:1693] Recovering from registrar
3: I1111 06:49:12.769352 15907 registrar.cpp:347] Recovering registrar
3: I1111 06:49:12.769801 15907 registrar.cpp:391] Successfully fetched the registry (0B) in 409856ns
3: I1111 06:49:12.769888 15907 registrar.cpp:495] Applied 1 operations in 29670ns; attempting to update the registry
3: I1111 06:49:12.770352 15907 registrar.cpp:552] Successfully updated the registry in 421120ns
3: I1111 06:49:12.770445 15907 registrar.cpp:424] Successfully recovered registrar
3: I1111 06:49:12.770748 15906 master.cpp:1806] Recovered 0 agents from the registry (129B); allowing 10mins for agents to re-register
3: I1111 06:49:12.770790 15916 hierarchical.cpp:209] Skipping recovery of hierarchical allocator: nothing to recover
3: W1111 06:49:12.774523 15901 process.cpp:3178] Attempted to spawn already running process files@172.17.0.3:55548
3: I1111 06:49:12.775336 15901 containerizer.cpp:301] Using isolation { environment_secret, posix/cpu, posix/mem, filesystem/posix, network/cni }
3: W1111 06:49:12.775775 15901 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
3: W1111 06:49:12.775877 15901 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
3: I1111 06:49:12.775907 15901 provisioner.cpp:255] Using default backend 'copy'
3: I1111 06:49:12.777566 15901 cluster.cpp:448] Creating default 'local' authorizer
3: I1111 06:49:12.779330 15904 slave.cpp:262] Mesos agent started on (485)@172.17.0.3:55548
3: I1111 06:49:12.779357 15904 slave.cpp:263] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/ReconciliationTest_UnknownTask_9p5fCd/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/ReconciliationTest_UnknownTask_9p5fCd/credential" --default_role="*" --disallow_sharing_agent_pid_namespace="false" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/ReconciliationTest_UnknownTask_9p5fCd/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/ReconciliationTest_UnknownTask_9p5fCd/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/ReconciliationTest_UnknownTask_9p5fCd/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/ReconciliationTest_UnknownTask_9p5fCd" --sandbox_directory="/mnt/mesos/sandbox" --strict="true" --switch_user="true" --systemd_enable_support="true" --systemd_runtime_directory="/run/systemd/system" --version="false" --work_dir="/tmp/ReconciliationTest_UnknownTask_OvGP5F" --zk_session_timeout="10secs"
3: I1111 06:49:12.779738 15904 credentials.hpp:86] Loading credential for authentication from '/tmp/ReconciliationTest_UnknownTask_9p5fCd/credential'
3: I1111 06:49:12.779875 15904 slave.cpp:295] Agent using credential for: test-principal
3: I1111 06:49:12.779896 15904 credentials.hpp:37] Loading credentials for authentication from '/tmp/ReconciliationTest_UnknownTask_9p5fCd/http_credentials'
3: I1111 06:49:12.780122 15904 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
3: I1111 06:49:12.780266 15904 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
3: I1111 06:49:12.781568 15904 slave.cpp:593] Agent resources: [{"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}]
3: I1111 06:49:12.781760 15904 slave.cpp:601] Agent attributes: [ ]
3: I1111 06:49:12.781774 15904 slave.cpp:610] Agent hostname: 5db355fcacb6
3: I1111 06:49:12.781919 15913 status_update_manager.cpp:177] Pausing sending status updates
3: I1111 06:49:12.783248 15908 state.cpp:64] Recovering state from '/tmp/ReconciliationTest_UnknownTask_OvGP5F/meta'
3: I1111 06:49:12.783556 15908 status_update_manager.cpp:203] Recovering status update manager
3: I1111 06:49:12.783726 15912 containerizer.cpp:662] Recovering containerizer
Build step 'Execute shell' marked build as failure
Jenkins build is back to normal : Mesos-Buildbot » cmake,clang,--verbose --disable-libtool-wrappers,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)&&(!qnode3)&&(!H23) #4446
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=cmake,COMPILER=clang,CONFIGURATION=--verbose%20--disable-libtool-wrappers,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)&&(!qnode3)&&(!H23)/4446/display/redirect>