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/17 19:51:03 UTC
Build failed in Jenkins: Mesos-Buildbot » cmake,gcc,--verbose --disable-libtool-wrappers --enable-libevent --enable-ssl,GLOG_v=1 MESOS_VERBOSE=1,centos:7,(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)&&(!qnode3)&&(!H23) #4469
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=cmake,COMPILER=gcc,CONFIGURATION=--verbose%20--disable-libtool-wrappers%20--enable-libevent%20--enable-ssl,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=centos%3A7,label_exp=(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)&&(!qnode3)&&(!H23)/4469/display/redirect?page=changes>
Changes:
[xujyan] Downgraded the logging level of socket shutdown failures.
------------------------------------------
[...truncated 3.47 MB...]
3: I1117 19:50:36.489372 18258 exec.cpp:435] Executor asked to shutdown
3: I1117 19:50:36.489473 18258 exec.cpp:450] Executor::shutdown took 83443ns
3: I1117 19:50:36.489651 18255 slave.cpp:5130] Got exited event for executor(7)@172.17.0.3:45499
3: I1117 19:50:36.490492 18237 hierarchical.cpp:1125] Recovered cpus(allocated: *):2; mem(allocated: *):1024; disk(allocated: *):1024; ports(allocated: *):[31000-32000] (total: cpus:2; mem:1024; disk:1024; ports:[31000-32000], allocated: {}) on agent b29bcb3f-b673-47f6-a55d-d913fbb30c43-S0 from framework b29bcb3f-b673-47f6-a55d-d913fbb30c43-0000
3: I1117 19:50:36.490130 18242 master.cpp:9596] Removing task 493e33b4-b050-4ddb-a2d0-968da79773ff with resources [{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}] of framework b29bcb3f-b673-47f6-a55d-d913fbb30c43-0000 on agent b29bcb3f-b673-47f6-a55d-d913fbb30c43-S0 at slave(51)@172.17.0.3:45499 (1fda6edcf409)
3: I1117 19:50:36.490969 18242 master.cpp:9625] Removing executor 'default' with resources [] of framework b29bcb3f-b673-47f6-a55d-d913fbb30c43-0000 on agent b29bcb3f-b673-47f6-a55d-d913fbb30c43-S0 at slave(51)@172.17.0.3:45499 (1fda6edcf409)
3: I1117 19:50:36.491134 18249 slave.cpp:5539] Executor 'default' of framework b29bcb3f-b673-47f6-a55d-d913fbb30c43-0000 exited with status 0
3: I1117 19:50:36.491222 18249 slave.cpp:5643] Cleaning up executor 'default' of framework b29bcb3f-b673-47f6-a55d-d913fbb30c43-0000 at executor(7)@172.17.0.3:45499
3: I1117 19:50:36.491552 18257 gc.cpp:90] Scheduling '/tmp/FaultToleranceTest_SchedulerFailoverFrameworkToExecutorMessage_slEDqD/slaves/b29bcb3f-b673-47f6-a55d-d913fbb30c43-S0/frameworks/b29bcb3f-b673-47f6-a55d-d913fbb30c43-0000/executors/default/runs/ca6d065d-9ec9-4d51-bb3b-cac6291a3310' for gc 6.99999431221037days in the future
3: I1117 19:50:36.491719 18249 slave.cpp:5750] Cleaning up framework b29bcb3f-b673-47f6-a55d-d913fbb30c43-0000
3: I1117 19:50:36.491745 18257 gc.cpp:90] Scheduling '/tmp/FaultToleranceTest_SchedulerFailoverFrameworkToExecutorMessage_slEDqD/slaves/b29bcb3f-b673-47f6-a55d-d913fbb30c43-S0/frameworks/b29bcb3f-b673-47f6-a55d-d913fbb30c43-0000/executors/default' for gc 6.99999430961778days in the future
3: I1117 19:50:36.491842 18253 hierarchical.cpp:355] Removed framework b29bcb3f-b673-47f6-a55d-d913fbb30c43-0000
3: I1117 19:50:36.491871 18259 status_update_manager.cpp:285] Closing status update streams for framework b29bcb3f-b673-47f6-a55d-d913fbb30c43-0000
3: I1117 19:50:36.491919 18259 status_update_manager.cpp:531] Cleaning up status update stream for task 493e33b4-b050-4ddb-a2d0-968da79773ff of framework b29bcb3f-b673-47f6-a55d-d913fbb30c43-0000
3: I1117 19:50:36.491955 18257 gc.cpp:90] Scheduling '/tmp/FaultToleranceTest_SchedulerFailoverFrameworkToExecutorMessage_slEDqD/slaves/b29bcb3f-b673-47f6-a55d-d913fbb30c43-S0/frameworks/b29bcb3f-b673-47f6-a55d-d913fbb30c43-0000' for gc 6.9999943071763days in the future
3: I1117 19:50:36.492079 18245 slave.cpp:883] Agent terminating
3: W1117 19:50:36.492346 18242 master.cpp:7453] Ignoring unknown exited executor 'default' of framework b29bcb3f-b673-47f6-a55d-d913fbb30c43-0000 on agent b29bcb3f-b673-47f6-a55d-d913fbb30c43-S0 at slave(51)@172.17.0.3:45499 (1fda6edcf409)
3: I1117 19:50:36.492467 18242 master.cpp:1309] Agent b29bcb3f-b673-47f6-a55d-d913fbb30c43-S0 at slave(51)@172.17.0.3:45499 (1fda6edcf409) disconnected
3: I1117 19:50:36.492488 18242 master.cpp:3368] Disconnecting agent b29bcb3f-b673-47f6-a55d-d913fbb30c43-S0 at slave(51)@172.17.0.3:45499 (1fda6edcf409)
3: I1117 19:50:36.492560 18242 master.cpp:3387] Deactivating agent b29bcb3f-b673-47f6-a55d-d913fbb30c43-S0 at slave(51)@172.17.0.3:45499 (1fda6edcf409)
3: I1117 19:50:36.492658 18244 hierarchical.cpp:690] Agent b29bcb3f-b673-47f6-a55d-d913fbb30c43-S0 deactivated
3: I1117 19:50:36.496050 18236 master.cpp:1151] Master terminating
3: I1117 19:50:36.496728 18251 hierarchical.cpp:626] Removed agent b29bcb3f-b673-47f6-a55d-d913fbb30c43-S0
3: [ OK ] FaultToleranceTest.SchedulerFailoverFrameworkToExecutorMessage (94 ms)
3: [ RUN ] FaultToleranceTest.IgnoreKillTaskFromUnregisteredFramework
3: I1117 19:50:36.504426 18235 cluster.cpp:162] Creating default 'local' authorizer
3: I1117 19:50:36.508651 18248 master.cpp:448] Master 46998356-53c4-4aa4-bb4d-b759838399fe (1fda6edcf409) started on 172.17.0.3:45499
3: I1117 19:50:36.508677 18248 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/HfStiK/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/HfStiK/master" --zk_session_timeout="10secs"
3: I1117 19:50:36.509033 18248 master.cpp:499] Master only allowing authenticated frameworks to register
3: I1117 19:50:36.509042 18248 master.cpp:505] Master only allowing authenticated agents to register
3: I1117 19:50:36.509045 18248 master.cpp:511] Master only allowing authenticated HTTP frameworks to register
3: I1117 19:50:36.509052 18248 credentials.hpp:37] Loading credentials for authentication from '/tmp/HfStiK/credentials'
3: I1117 19:50:36.509387 18248 master.cpp:555] Using default 'crammd5' authenticator
3: I1117 19:50:36.509541 18248 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readonly'
3: I1117 19:50:36.509718 18248 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readwrite'
3: I1117 19:50:36.509841 18248 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-master-scheduler'
3: I1117 19:50:36.509955 18248 master.cpp:634] Authorization enabled
3: I1117 19:50:36.510110 18254 hierarchical.cpp:171] Initialized hierarchical allocator process
3: I1117 19:50:36.510152 18247 whitelist_watcher.cpp:77] No whitelist given
3: I1117 19:50:36.513212 18249 master.cpp:2213] Elected as the leading master!
3: I1117 19:50:36.513244 18249 master.cpp:1693] Recovering from registrar
3: I1117 19:50:36.513375 18239 registrar.cpp:347] Recovering registrar
3: I1117 19:50:36.514000 18239 registrar.cpp:391] Successfully fetched the registry (0B) in 585984ns
3: I1117 19:50:36.514122 18239 registrar.cpp:495] Applied 1 operations in 40466ns; attempting to update the registry
3: I1117 19:50:36.514675 18239 registrar.cpp:552] Successfully updated the registry in 497152ns
3: I1117 19:50:36.514788 18239 registrar.cpp:424] Successfully recovered registrar
3: I1117 19:50:36.515179 18243 hierarchical.cpp:209] Skipping recovery of hierarchical allocator: nothing to recover
3: I1117 19:50:36.515169 18238 master.cpp:1806] Recovered 0 agents from the registry (129B); allowing 10mins for agents to re-register
3: W1117 19:50:36.520541 18235 process.cpp:3185] Attempted to spawn already running process files@172.17.0.3:45499
3: I1117 19:50:36.520946 18235 cluster.cpp:448] Creating default 'local' authorizer
3: I1117 19:50:36.523207 18236 slave.cpp:262] Mesos agent started on (52)@172.17.0.3:45499
3: W1117 19:50:36.523831 18235 process.cpp:3185] Attempted to spawn already running process version@172.17.0.3:45499
3: I1117 19:50:36.523234 18236 slave.cpp:263] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/FaultToleranceTest_IgnoreKillTaskFromUnregisteredFramework_ppKj1N/store/appc" --authenticate_http_executors="true" --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/FaultToleranceTest_IgnoreKillTaskFromUnregisteredFramework_ppKj1N/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/FaultToleranceTest_IgnoreKillTaskFromUnregisteredFramework_ppKj1N/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_secret_key="/tmp/FaultToleranceTest_IgnoreKillTaskFromUnregisteredFramework_ppKj1N/executor_secret_key" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/FaultToleranceTest_IgnoreKillTaskFromUnregisteredFramework_ppKj1N/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/FaultToleranceTest_IgnoreKillTaskFromUnregisteredFramework_ppKj1N/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/FaultToleranceTest_IgnoreKillTaskFromUnregisteredFramework_ppKj1N" --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/FaultToleranceTest_IgnoreKillTaskFromUnregisteredFramework_m90S9L" --zk_session_timeout="10secs"
3: I1117 19:50:36.523973 18236 credentials.hpp:86] Loading credential for authentication from '/tmp/FaultToleranceTest_IgnoreKillTaskFromUnregisteredFramework_ppKj1N/credential'
3: I1117 19:50:36.524236 18236 slave.cpp:295] Agent using credential for: test-principal
3: I1117 19:50:36.524263 18236 credentials.hpp:37] Loading credentials for authentication from '/tmp/FaultToleranceTest_IgnoreKillTaskFromUnregisteredFramework_ppKj1N/http_credentials'
3: I1117 19:50:36.524721 18236 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-executor'
3: I1117 19:50:36.524946 18236 http.cpp:1066] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-executor'
3: I1117 19:50:36.525189 18235 sched.cpp:232] Version: 1.5.0
3: I1117 19:50:36.525451 18236 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
3: I1117 19:50:36.525660 18236 http.cpp:1066] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readonly'
3: I1117 19:50:36.526042 18236 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
3: I1117 19:50:36.526228 18246 sched.cpp:336] New master detected at master@172.17.0.3:45499
3: I1117 19:50:36.526250 18236 http.cpp:1066] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readwrite'
3: I1117 19:50:36.526458 18246 sched.cpp:396] Authenticating with master master@172.17.0.3:45499
3: I1117 19:50:36.526497 18246 sched.cpp:403] Using default CRAM-MD5 authenticatee
3: I1117 19:50:36.527016 18257 authenticatee.cpp:121] Creating new client SASL connection
3: I1117 19:50:36.527565 18240 master.cpp:8285] Authenticating scheduler-ad8a16c2-73b2-4dc3-9e4f-b536b098f916@172.17.0.3:45499
3: I1117 19:50:36.527765 18252 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(117)@172.17.0.3:45499
3: I1117 19:50:36.528226 18245 authenticator.cpp:98] Creating new server SASL connection
3: I1117 19:50:36.528612 18239 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
3: I1117 19:50:36.528648 18239 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
3: I1117 19:50:36.528919 18242 authenticator.cpp:204] Received SASL authentication start
3: I1117 19:50:36.529008 18242 authenticator.cpp:326] Authentication requires more steps
3: I1117 19:50:36.529183 18244 authenticatee.cpp:259] Received SASL authentication step
3: I1117 19:50:36.529363 18244 authenticator.cpp:232] Received SASL authentication step
3: I1117 19:50:36.529405 18244 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '1fda6edcf409' server FQDN: '1fda6edcf409' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
3: I1117 19:50:36.529428 18244 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
3: I1117 19:50:36.529484 18244 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
3: I1117 19:50:36.529525 18244 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '1fda6edcf409' server FQDN: '1fda6edcf409' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
3: I1117 19:50:36.529544 18244 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
3: I1117 19:50:36.529556 18244 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
3: I1117 19:50:36.529579 18244 authenticator.cpp:318] Authentication success
3: I1117 19:50:36.529729 18256 authenticatee.cpp:299] Authentication success
3: I1117 19:50:36.529290 18236 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: I1117 19:50:36.529775 18238 master.cpp:8315] Successfully authenticated principal 'test-principal' at scheduler-ad8a16c2-73b2-4dc3-9e4f-b536b098f916@172.17.0.3:45499
3: I1117 19:50:36.529798 18236 slave.cpp:601] Agent attributes: [ ]
3: I1117 19:50:36.529814 18236 slave.cpp:610] Agent hostname: 1fda6edcf409
3: I1117 19:50:36.529844 18237 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(117)@172.17.0.3:45499
3: I1117 19:50:36.529995 18253 status_update_manager.cpp:177] Pausing sending status updates
3: I1117 19:50:36.532148 18249 state.cpp:64] Recovering state from '/tmp/FaultToleranceTest_IgnoreKillTaskFromUnregisteredFramework_m90S9L/meta'
3: I1117 19:50:36.532413 18251 sched.cpp:502] Successfully authenticated with master master@172.17.0.3:45499
3: I1117 19:50:36.532436 18251 sched.cpp:824] Sending SUBSCRIBE call to master@172.17.0.3:45499
3: I1117 19:50:36.532547 18257 status_update_manager.cpp:203] Recovering status update manager
3: I1117 19:50:36.532589 18251 sched.cpp:857] Will retry registration in 114.613811ms if necessary
3: I1117 19:50:36.532902 18240 master.cpp:2961] Received SUBSCRIBE call for framework 'default' at scheduler-ad8a16c2-73b2-4dc3-9e4f-b536b098f916@172.17.0.3:45499
3: I1117 19:50:36.533010 18240 master.cpp:2278] Authorizing framework principal 'test-principal' to receive offers for roles '{ * }'
3: I1117 19:50:36.533088 18239 slave.cpp:6441] Finished recovery
3: I1117 19:50:36.533656 18243 master.cpp:3041] Subscribing framework default with checkpointing disabled and capabilities [ RESERVATION_REFINEMENT ]
3: I1117 19:50:36.534270 18241 slave.cpp:1007] New master detected at master@172.17.0.3:45499
3: I1117 19:50:36.534358 18243 status_update_manager.cpp:177] Pausing sending status updates
3: I1117 19:50:36.534405 18241 slave.cpp:1042] Detecting new master
3: I1117 19:50:36.534569 18243 sched.cpp:751] Framework registered with 46998356-53c4-4aa4-bb4d-b759838399fe-0000
3: I1117 19:50:36.534585 18239 hierarchical.cpp:303] Added framework 46998356-53c4-4aa4-bb4d-b759838399fe-0000
3: I1117 19:50:36.534632 18243 sched.cpp:765] Scheduler::registered took 37029ns
3: I1117 19:50:36.534826 18239 hierarchical.cpp:1450] Performed allocation for 0 agents in 85037ns
3: I1117 19:50:36.537736 18236 slave.cpp:1069] Authenticating with master master@172.17.0.3:45499
3: I1117 19:50:36.537833 18236 slave.cpp:1078] Using default CRAM-MD5 authenticatee
3: I1117 19:50:36.538179 18256 authenticatee.cpp:121] Creating new client SASL connection
3: I1117 19:50:36.538604 18254 master.cpp:8285] Authenticating slave(52)@172.17.0.3:45499
3: I1117 19:50:36.538755 18259 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(118)@172.17.0.3:45499
3: I1117 19:50:36.539069 18249 authenticator.cpp:98] Creating new server SASL connection
3: I1117 19:50:36.539363 18246 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
3: I1117 19:50:36.539399 18246 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
3: I1117 19:50:36.539574 18250 authenticator.cpp:204] Received SASL authentication start
3: I1117 19:50:36.539660 18250 authenticator.cpp:326] Authentication requires more steps
3: I1117 19:50:36.539819 18257 authenticatee.cpp:259] Received SASL authentication step
3: I1117 19:50:36.539988 18251 authenticator.cpp:232] Received SASL authentication step
3: I1117 19:50:36.540055 18251 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '1fda6edcf409' server FQDN: '1fda6edcf409' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
3: I1117 19:50:36.540081 18251 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
3: I1117 19:50:36.540181 18251 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
3: I1117 19:50:36.540220 18251 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '1fda6edcf409' server FQDN: '1fda6edcf409' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
3: I1117 19:50:36.540236 18251 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
3: I1117 19:50:36.540248 18251 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
3: I1117 19:50:36.540272 18251 authenticator.cpp:318] Authentication success
3: I1117 19:50:36.540401 18252 authenticatee.cpp:299] Authentication success
3: I1117 19:50:36.540490 18245 master.cpp:8315] Successfully authenticated principal 'test-principal' at slave(52)@172.17.0.3:45499
3: I1117 19:50:36.540590 18251 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(118)@172.17.0.3:45499
3: I1117 19:50:36.540819 18252 slave.cpp:1161] Successfully authenticated with master master@172.17.0.3:45499
3: I1117 19:50:36.541249 18252 slave.cpp:1682] Will retry registration in 9.349107ms if necessary
3: I1117 19:50:36.541610 18241 master.cpp:6032] Received register agent message from slave(52)@172.17.0.3:45499 (1fda6edcf409)
3: I1117 19:50:36.541790 18241 master.cpp:3870] Authorizing agent with principal 'test-principal'
3: I1117 19:50:36.542443 18248 master.cpp:6092] Authorized registration of agent at slave(52)@172.17.0.3:45499 (1fda6edcf409)
3: I1117 19:50:36.542632 18248 master.cpp:6185] Registering agent at slave(52)@172.17.0.3:45499 (1fda6edcf409) with id 46998356-53c4-4aa4-bb4d-b759838399fe-S0
3: I1117 19:50:36.543211 18255 registrar.cpp:495] Applied 1 operations in 89515ns; attempting to update the registry
3: I1117 19:50:36.544137 18255 registrar.cpp:552] Successfully updated the registry in 844032ns
3: I1117 19:50:36.544489 18255 master.cpp:6232] Admitted agent 46998356-53c4-4aa4-bb4d-b759838399fe-S0 at slave(52)@172.17.0.3:45499 (1fda6edcf409)
3: I1117 19:50:36.545578 18259 slave.cpp:1207] Registered with master master@172.17.0.3:45499; given agent ID 46998356-53c4-4aa4-bb4d-b759838399fe-S0
3: I1117 19:50:36.545334 18255 master.cpp:6263] Registered agent 46998356-53c4-4aa4-bb4d-b759838399fe-S0 at slave(52)@172.17.0.3:45499 (1fda6edcf409) 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: I1117 19:50:36.545784 18250 status_update_manager.cpp:184] Resuming sending status updates
3: I1117 19:50:36.545943 18254 hierarchical.cpp:593] Added agent 46998356-53c4-4aa4-bb4d-b759838399fe-S0 (1fda6edcf409) with cpus:2; mem:1024; disk:1024; ports:[31000-32000] (allocated: {})
3: I1117 19:50:36.546149 18259 slave.cpp:1227] Checkpointing SlaveInfo to '/tmp/FaultToleranceTest_IgnoreKillTaskFromUnregisteredFramework_m90S9L/meta/slaves/46998356-53c4-4aa4-bb4d-b759838399fe-S0/slave.info'
3: I1117 19:50:36.546836 18259 slave.cpp:1295] Forwarding total oversubscribed resources {}
3: I1117 19:50:36.547086 18257 master.cpp:7064] Received update of agent 46998356-53c4-4aa4-bb4d-b759838399fe-S0 at slave(52)@172.17.0.3:45499 (1fda6edcf409) with total oversubscribed resources {}
3: I1117 19:50:36.547274 18257 master.cpp:7082] Ignoring update on agent 46998356-53c4-4aa4-bb4d-b759838399fe-S0 at slave(52)@172.17.0.3:45499 (1fda6edcf409) as it reports no changes
3: I1117 19:50:36.548058 18254 hierarchical.cpp:1450] Performed allocation for 1 agents in 1.869116ms
3: I1117 19:50:36.548775 18245 master.cpp:8115] Sending 1 offers to framework 46998356-53c4-4aa4-bb4d-b759838399fe-0000 (default) at scheduler-ad8a16c2-73b2-4dc3-9e4f-b536b098f916@172.17.0.3:45499
3: I1117 19:50:36.550415 18244 sched.cpp:921] Scheduler::resourceOffers took 976715ns
3: I1117 19:50:36.551985 18251 master.cpp:10024] Removing offer 46998356-53c4-4aa4-bb4d-b759838399fe-O0
3: I1117 19:50:36.552145 18251 master.cpp:4228] Processing ACCEPT call for offers: [ 46998356-53c4-4aa4-bb4d-b759838399fe-O0 ] on agent 46998356-53c4-4aa4-bb4d-b759838399fe-S0 at slave(52)@172.17.0.3:45499 (1fda6edcf409) for framework 46998356-53c4-4aa4-bb4d-b759838399fe-0000 (default) at scheduler-ad8a16c2-73b2-4dc3-9e4f-b536b098f916@172.17.0.3:45499
3: I1117 19:50:36.552263 18251 master.cpp:3597] Authorizing framework principal 'test-principal' to launch task 0
3: W1117 19:50:36.554814 18253 validation.cpp:1391] 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: W1117 19:50:36.554867 18253 validation.cpp:1403] 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: I1117 19:50:36.555505 18253 master.cpp:10770] 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 46998356-53c4-4aa4-bb4d-b759838399fe-S0 at slave(52)@172.17.0.3:45499 (1fda6edcf409)
3: I1117 19:50:36.556133 18253 master.cpp:4976] Launching task 0 of framework 46998356-53c4-4aa4-bb4d-b759838399fe-0000 (default) at scheduler-ad8a16c2-73b2-4dc3-9e4f-b536b098f916@172.17.0.3:45499 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 46998356-53c4-4aa4-bb4d-b759838399fe-S0 at slave(52)@172.17.0.3:45499 (1fda6edcf409)
3: I1117 19:50:36.556911 18238 slave.cpp:1803] Got assigned task '0' for framework 46998356-53c4-4aa4-bb4d-b759838399fe-0000
3: I1117 19:50:36.557626 18238 slave.cpp:2071] Authorizing task '0' for framework 46998356-53c4-4aa4-bb4d-b759838399fe-0000
3: I1117 19:50:36.557690 18238 slave.cpp:7262] Authorizing framework principal 'test-principal' to launch task 0
3: I1117 19:50:36.557740 18241 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 46998356-53c4-4aa4-bb4d-b759838399fe-S0 from framework 46998356-53c4-4aa4-bb4d-b759838399fe-0000
3: I1117 19:50:36.557844 18241 hierarchical.cpp:1171] Framework 46998356-53c4-4aa4-bb4d-b759838399fe-0000 filtered agent 46998356-53c4-4aa4-bb4d-b759838399fe-S0 for 5secs
3: I1117 19:50:36.558717 18243 slave.cpp:2239] Launching task '0' for framework 46998356-53c4-4aa4-bb4d-b759838399fe-0000
3: I1117 19:50:36.559386 18243 paths.cpp:621] Trying to chown '/tmp/FaultToleranceTest_IgnoreKillTaskFromUnregisteredFramework_m90S9L/slaves/46998356-53c4-4aa4-bb4d-b759838399fe-S0/frameworks/46998356-53c4-4aa4-bb4d-b759838399fe-0000/executors/default/runs/e204da92-9bea-48d4-bf46-11fd0bfdb8c2' to user 'mesos'
3: I1117 19:50:36.559715 18243 slave.cpp:7736] Launching executor 'default' of framework 46998356-53c4-4aa4-bb4d-b759838399fe-0000 with resources [] in work directory '/tmp/FaultToleranceTest_IgnoreKillTaskFromUnregisteredFramework_m90S9L/slaves/46998356-53c4-4aa4-bb4d-b759838399fe-S0/frameworks/46998356-53c4-4aa4-bb4d-b759838399fe-0000/executors/default/runs/e204da92-9bea-48d4-bf46-11fd0bfdb8c2'
3: I1117 19:50:36.560662 18243 slave.cpp:2467] Queued task '0' for executor 'default' of framework 46998356-53c4-4aa4-bb4d-b759838399fe-0000
3: I1117 19:50:36.560747 18243 slave.cpp:958] Successfully attached '/tmp/FaultToleranceTest_IgnoreKillTaskFromUnregisteredFramework_m90S9L/slaves/46998356-53c4-4aa4-bb4d-b759838399fe-S0/frameworks/46998356-53c4-4aa4-bb4d-b759838399fe-0000/executors/default/runs/e204da92-9bea-48d4-bf46-11fd0bfdb8c2' to virtual path '/tmp/FaultToleranceTest_IgnoreKillTaskFromUnregisteredFramework_m90S9L/slaves/46998356-53c4-4aa4-bb4d-b759838399fe-S0/frameworks/46998356-53c4-4aa4-bb4d-b759838399fe-0000/executors/default/runs/latest'
3: I1117 19:50:36.560788 18243 slave.cpp:958] Successfully attached '/tmp/FaultToleranceTest_IgnoreKillTaskFromUnregisteredFramework_m90S9L/slaves/46998356-53c4-4aa4-bb4d-b759838399fe-S0/frameworks/46998356-53c4-4aa4-bb4d-b759838399fe-0000/executors/default/runs/e204da92-9bea-48d4-bf46-11fd0bfdb8c2' to virtual path '/frameworks/46998356-53c4-4aa4-bb4d-b759838399fe-0000/executors/default/runs/latest'
3: I1117 19:50:36.561074 18243 slave.cpp:2930] Launching container e204da92-9bea-48d4-bf46-11fd0bfdb8c2 for executor 'default' of framework 46998356-53c4-4aa4-bb4d-b759838399fe-0000
3: I1117 19:50:36.561381 18243 slave.cpp:958] Successfully attached '/tmp/FaultToleranceTest_IgnoreKillTaskFromUnregisteredFramework_m90S9L/slaves/46998356-53c4-4aa4-bb4d-b759838399fe-S0/frameworks/46998356-53c4-4aa4-bb4d-b759838399fe-0000/executors/default/runs/e204da92-9bea-48d4-bf46-11fd0bfdb8c2' to virtual path '/tmp/FaultToleranceTest_IgnoreKillTaskFromUnregisteredFramework_m90S9L/slaves/46998356-53c4-4aa4-bb4d-b759838399fe-S0/frameworks/46998356-53c4-4aa4-bb4d-b759838399fe-0000/executors/default/runs/e204da92-9bea-48d4-bf46-11fd0bfdb8c2'
3: W1117 19:50:36.564013 18236 process.cpp:3185] Attempted to spawn already running process version@172.17.0.3:45499
3: I1117 19:50:36.564252 18236 exec.cpp:162] Version: 1.5.0
3: I1117 19:50:36.564577 18255 exec.cpp:212] Executor started at: executor(8)@172.17.0.3:45499 with pid 18235
3: I1117 19:50:36.564988 18250 slave.cpp:4063] Got registration for executor 'default' of framework 46998356-53c4-4aa4-bb4d-b759838399fe-0000 from executor(8)@172.17.0.3:45499
3: I1117 19:50:36.565593 18259 exec.cpp:237] Executor registered on agent 46998356-53c4-4aa4-bb4d-b759838399fe-S0
3: I1117 19:50:36.565662 18259 exec.cpp:249] Executor::registered took 39895ns
3: I1117 19:50:36.566131 18250 slave.cpp:2669] Sending queued task '0' to executor 'default' of framework 46998356-53c4-4aa4-bb4d-b759838399fe-0000 at executor(8)@172.17.0.3:45499
3: I1117 19:50:36.566599 18254 exec.cpp:331] Executor asked to run task '0'
3: I1117 19:50:36.566711 18254 exec.cpp:340] Executor::launchTask took 86505ns
3: I1117 19:50:36.566841 18254 exec.cpp:571] Executor sending status update TASK_RUNNING (UUID: 290d7eec-e909-4ae2-8a22-6d3b95a2fa24) for task 0 of framework 46998356-53c4-4aa4-bb4d-b759838399fe-0000
3: I1117 19:50:36.567191 18245 slave.cpp:4517] Handling status update TASK_RUNNING (UUID: 290d7eec-e909-4ae2-8a22-6d3b95a2fa24) for task 0 of framework 46998356-53c4-4aa4-bb4d-b759838399fe-0000 from executor(8)@172.17.0.3:45499
3: I1117 19:50:36.567909 18251 status_update_manager.cpp:323] Received status update TASK_RUNNING (UUID: 290d7eec-e909-4ae2-8a22-6d3b95a2fa24) for task 0 of framework 46998356-53c4-4aa4-bb4d-b759838399fe-0000
3: I1117 19:50:36.567951 18251 status_update_manager.cpp:500] Creating StatusUpdate stream for task 0 of framework 46998356-53c4-4aa4-bb4d-b759838399fe-0000
3: I1117 19:50:36.568390 18251 status_update_manager.cpp:377] Forwarding update TASK_RUNNING (UUID: 290d7eec-e909-4ae2-8a22-6d3b95a2fa24) for task 0 of framework 46998356-53c4-4aa4-bb4d-b759838399fe-0000 to the agent
3: I1117 19:50:36.568610 18252 slave.cpp:4998] Forwarding the update TASK_RUNNING (UUID: 290d7eec-e909-4ae2-8a22-6d3b95a2fa24) for task 0 of framework 46998356-53c4-4aa4-bb4d-b759838399fe-0000 to master@172.17.0.3:45499
3: I1117 19:50:36.568909 18252 slave.cpp:4892] Status update manager successfully handled status update TASK_RUNNING (UUID: 290d7eec-e909-4ae2-8a22-6d3b95a2fa24) for task 0 of framework 46998356-53c4-4aa4-bb4d-b759838399fe-0000
3: I1117 19:50:36.568975 18252 slave.cpp:4908] Sending acknowledgement for status update TASK_RUNNING (UUID: 290d7eec-e909-4ae2-8a22-6d3b95a2fa24) for task 0 of framework 46998356-53c4-4aa4-bb4d-b759838399fe-0000 to executor(8)@172.17.0.3:45499
3: I1117 19:50:36.569079 18242 master.cpp:7247] Status update TASK_RUNNING (UUID: 290d7eec-e909-4ae2-8a22-6d3b95a2fa24) for task 0 of framework 46998356-53c4-4aa4-bb4d-b759838399fe-0000 from agent 46998356-53c4-4aa4-bb4d-b759838399fe-S0 at slave(52)@172.17.0.3:45499 (1fda6edcf409)
3: I1117 19:50:36.569138 18242 master.cpp:7309] Forwarding status update TASK_RUNNING (UUID: 290d7eec-e909-4ae2-8a22-6d3b95a2fa24) for task 0 of framework 46998356-53c4-4aa4-bb4d-b759838399fe-0000
3: I1117 19:50:36.569187 18240 exec.cpp:388] Executor received status update acknowledgement 290d7eec-e909-4ae2-8a22-6d3b95a2fa24 for task 0 of framework 46998356-53c4-4aa4-bb4d-b759838399fe-0000
3: I1117 19:50:36.569315 18242 master.cpp:9502] Updating the state of task 0 of framework 46998356-53c4-4aa4-bb4d-b759838399fe-0000 (latest state: TASK_RUNNING, status update state: TASK_RUNNING)
3: I1117 19:50:36.569625 18240 sched.cpp:1029] Scheduler::statusUpdate took 109669ns
3: I1117 19:50:36.570327 18239 master.cpp:5791] Processing ACKNOWLEDGE call 290d7eec-e909-4ae2-8a22-6d3b95a2fa24 for task 0 of framework 46998356-53c4-4aa4-bb4d-b759838399fe-0000 (default) at scheduler-ad8a16c2-73b2-4dc3-9e4f-b536b098f916@172.17.0.3:45499 on agent 46998356-53c4-4aa4-bb4d-b759838399fe-S0
3: I1117 19:50:36.570706 18246 status_update_manager.cpp:395] Received status update acknowledgement (UUID: 290d7eec-e909-4ae2-8a22-6d3b95a2fa24) for task 0 of framework 46998356-53c4-4aa4-bb4d-b759838399fe-0000
3: I1117 19:50:36.570996 18257 slave.cpp:3801] Status update manager successfully handled status update acknowledgement (UUID: 290d7eec-e909-4ae2-8a22-6d3b95a2fa24) for task 0 of framework 46998356-53c4-4aa4-bb4d-b759838399fe-0000
3: W1117 19:50:36.571036 18235 process.cpp:3185] Attempted to spawn already running process version@172.17.0.3:45499
3: I1117 19:50:36.571925 18235 sched.cpp:232] Version: 1.5.0
3: I1117 19:50:36.572602 18252 sched.cpp:336] New master detected at master@172.17.0.3:45499
3: I1117 19:50:36.572722 18252 sched.cpp:396] Authenticating with master master@172.17.0.3:45499
3: I1117 19:50:36.572743 18252 sched.cpp:403] Using default CRAM-MD5 authenticatee
3: I1117 19:50:36.573071 18242 authenticatee.cpp:121] Creating new client SASL connection
3: I1117 19:50:36.573366 18238 master.cpp:8285] Authenticating scheduler-5e0482cf-c2c3-4ec4-a97f-05428f82c5ab@172.17.0.3:45499
3: I1117 19:50:36.573482 18241 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(119)@172.17.0.3:45499
3: I1117 19:50:36.573758 18247 authenticator.cpp:98] Creating new server SASL connection
3: I1117 19:50:36.574024 18248 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
3: I1117 19:50:36.574049 18248 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
3: I1117 19:50:36.574183 18240 authenticator.cpp:204] Received SASL authentication start
3: I1117 19:50:36.574255 18240 authenticator.cpp:326] Authentication requires more steps
3: I1117 19:50:36.574384 18258 authenticatee.cpp:259] Received SASL authentication step
3: I1117 19:50:36.574532 18256 authenticator.cpp:232] Received SASL authentication step
3: I1117 19:50:36.574573 18256 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '1fda6edcf409' server FQDN: '1fda6edcf409' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
3: I1117 19:50:36.574590 18256 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
3: I1117 19:50:36.574637 18256 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
3: I1117 19:50:36.574666 18256 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '1fda6edcf409' server FQDN: '1fda6edcf409' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
3: I1117 19:50:36.574683 18256 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
3: I1117 19:50:36.574693 18256 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
3: I1117 19:50:36.574712 18256 authenticator.cpp:318] Authentication success
3: I1117 19:50:36.574818 18249 authenticatee.cpp:299] Authentication success
3: I1117 19:50:36.574903 18243 master.cpp:8315] Successfully authenticated principal 'test-principal' at scheduler-5e0482cf-c2c3-4ec4-a97f-05428f82c5ab@172.17.0.3:45499
3: I1117 19:50:36.574995 18249 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(119)@172.17.0.3:45499
3: I1117 19:50:36.581138 18255 sched.cpp:502] Successfully authenticated with master master@172.17.0.3:45499
3: I1117 19:50:36.581174 18255 sched.cpp:824] Sending SUBSCRIBE call to master@172.17.0.3:45499
3: I1117 19:50:36.581363 18255 sched.cpp:857] Will retry registration in 1.103362835secs if necessary
3: I1117 19:50:36.581679 18250 master.cpp:2961] Received SUBSCRIBE call for framework 'default' at scheduler-5e0482cf-c2c3-4ec4-a97f-05428f82c5ab@172.17.0.3:45499
3: I1117 19:50:36.581800 18250 master.cpp:2278] Authorizing framework principal 'test-principal' to receive offers for roles '{ * }'
3: I1117 19:50:36.582449 18244 master.cpp:3041] Subscribing framework default with checkpointing disabled and capabilities [ RESERVATION_REFINEMENT ]
3: I1117 19:50:36.582516 18244 master.cpp:6967] Updating info for framework 46998356-53c4-4aa4-bb4d-b759838399fe-0000
3: I1117 19:50:36.582655 18244 master.cpp:3150] Framework 46998356-53c4-4aa4-bb4d-b759838399fe-0000 (default) at scheduler-ad8a16c2-73b2-4dc3-9e4f-b536b098f916@172.17.0.3:45499 failed over
3: I1117 19:50:36.583123 18252 sched.cpp:751] Framework registered with 46998356-53c4-4aa4-bb4d-b759838399fe-0000
3: I1117 19:50:36.583230 18252 sched.cpp:765] Scheduler::registered took 74707ns
3: I1117 19:50:36.583272 18238 slave.cpp:3438] Updating info for framework 46998356-53c4-4aa4-bb4d-b759838399fe-0000 with pid updated to scheduler-5e0482cf-c2c3-4ec4-a97f-05428f82c5ab@172.17.0.3:45499
3: I1117 19:50:36.583384 18248 status_update_manager.cpp:184] Resuming sending status updates
3: W1117 19:50:36.584046 18243 master.cpp:2344] Dropping KILL call from framework 46998356-53c4-4aa4-bb4d-b759838399fe-0000 at scheduler-ad8a16c2-73b2-4dc3-9e4f-b536b098f916@172.17.0.3:45499: Call is not from registered framework
3: I1117 19:50:36.584465 18255 exec.cpp:571] Executor sending status update TASK_FINISHED (UUID: e8e54a97-dfc1-46c4-b815-1d680a744c74) for task 0 of framework 46998356-53c4-4aa4-bb4d-b759838399fe-0000
3: I1117 19:50:36.584982 18237 slave.cpp:4517] Handling status update TASK_FINISHED (UUID: e8e54a97-dfc1-46c4-b815-1d680a744c74) for task 0 of framework 46998356-53c4-4aa4-bb4d-b759838399fe-0000 from executor(8)@172.17.0.3:45499
3: I1117 19:50:36.586194 18253 status_update_manager.cpp:323] Received status update TASK_FINISHED (UUID: e8e54a97-dfc1-46c4-b815-1d680a744c74) for task 0 of framework 46998356-53c4-4aa4-bb4d-b759838399fe-0000
3: I1117 19:50:36.586378 18253 status_update_manager.cpp:377] Forwarding update TASK_FINISHED (UUID: e8e54a97-dfc1-46c4-b815-1d680a744c74) for task 0 of framework 46998356-53c4-4aa4-bb4d-b759838399fe-0000 to the agent
3: I1117 19:50:36.586616 18251 slave.cpp:4998] Forwarding the update TASK_FINISHED (UUID: e8e54a97-dfc1-46c4-b815-1d680a744c74) for task 0 of framework 46998356-53c4-4aa4-bb4d-b759838399fe-0000 to master@172.17.0.3:45499
3: I1117 19:50:36.586880 18251 slave.cpp:4892] Status update manager successfully handled status update TASK_FINISHED (UUID: e8e54a97-dfc1-46c4-b815-1d680a744c74) for task 0 of framework 46998356-53c4-4aa4-bb4d-b759838399fe-0000
3: I1117 19:50:36.586940 18251 slave.cpp:4908] Sending acknowledgement for status update TASK_FINISHED (UUID: e8e54a97-dfc1-46c4-b815-1d680a744c74) for task 0 of framework 46998356-53c4-4aa4-bb4d-b759838399fe-0000 to executor(8)@172.17.0.3:45499
3: I1117 19:50:36.587152 18251 exec.cpp:388] Executor received status update acknowledgement e8e54a97-dfc1-46c4-b815-1d680a744c74 for task 0 of framework 46998356-53c4-4aa4-bb4d-b759838399fe-0000
3: I1117 19:50:36.587121 18252 master.cpp:7247] Status update TASK_FINISHED (UUID: e8e54a97-dfc1-46c4-b815-1d680a744c74) for task 0 of framework 46998356-53c4-4aa4-bb4d-b759838399fe-0000 from agent 46998356-53c4-4aa4-bb4d-b759838399fe-S0 at slave(52)@172.17.0.3:45499 (1fda6edcf409)
3: I1117 19:50:36.587208 18252 master.cpp:7309] Forwarding status update TASK_FINISHED (UUID: e8e54a97-dfc1-46c4-b815-1d680a744c74) for task 0 of framework 46998356-53c4-4aa4-bb4d-b759838399fe-0000
3: I1117 19:50:36.587469 18252 master.cpp:9502] Updating the state of task 0 of framework 46998356-53c4-4aa4-bb4d-b759838399fe-0000 (latest state: TASK_FINISHED, status update state: TASK_FINISHED)
3: I1117 19:50:36.587783 18238 sched.cpp:1029] Scheduler::statusUpdate took 106125ns
3: I1117 19:50:36.588248 18235 sched.cpp:2009] Asked to stop the driver
3: I1117 19:50:36.588320 18235 sched.cpp:2009] Asked to stop the driver
write /dev/stdout: resource temporarily unavailable
+ docker rmi mesos-1510945795-7404
Build step 'Execute shell' marked build as failure
Not sending mail to unregistered user xujyan@apple.com
Jenkins build is back to normal : Mesos-Buildbot » cmake,gcc,--verbose --disable-libtool-wrappers --enable-libevent --enable-ssl,GLOG_v=1 MESOS_VERBOSE=1,centos:7,(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)&&(!qnode3)&&(!H23) #4470
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=cmake,COMPILER=gcc,CONFIGURATION=--verbose%20--disable-libtool-wrappers%20--enable-libevent%20--enable-ssl,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=centos%3A7,label_exp=(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)&&(!qnode3)&&(!H23)/4470/display/redirect?page=changes>