[
https://issues.apache.org/jira/browse/MESOS-1533?page=com.atlassian.jira.plugin.system.issuetabpanels:all-tabpanel
]
Adam B resolved MESOS-1533.
---------------------------
Resolution: Fixed
Fix Version/s: 0.20.0
commit 7747a3d0351e05a4e5fa6cf2f5433e4d1621379c
Author: Timothy Chen <[email protected]>
Date: Thu Jul 17 01:07:54 2014 -0700
Re-enabled health check tests
Currently the health check tests are disabled as it was flaky. Part of the
reason is that all assertions was EXPECTs instead of ASSERTs so it will
continue to execute.
Another issue was it's currently discovering the path to launch health
check executable from the command executor main argv[0] path.
However, the correct path is to launch the generated script that does
library path resolution, which is the parent of .libs.
Review: https://reviews.apache.org/r/23443
> HealthCheck tests are flaky
> ---------------------------
>
> Key: MESOS-1533
> URL: https://issues.apache.org/jira/browse/MESOS-1533
> Project: Mesos
> Issue Type: Bug
> Components: test
> Reporter: Benjamin Mahler
> Assignee: Timothy Chen
> Fix For: 0.20.0
>
>
> Hey [~tnachen], looks like the health check test is flaky, can you take a
> look?
> You can run tests with repetition to make sure they are not flaky:
> {noformat}
> ./bin/mesos-tests.sh --gtest_filter="HealthCheckTest.HealthyTask"
> --gtest_break_on_failure --gtest_repeat=-1 --verbose
> {noformat}
> {noformat}
> [----------] 4 tests from HealthCheckTest
> [ RUN ] HealthCheckTest.HealthyTask
> Using temporary directory '/tmp/HealthCheckTest_HealthyTask_MOxO1V'
> I0623 13:29:05.958271 11026 leveldb.cpp:176] Opened db in 27.890327ms
> I0623 13:29:05.971760 11026 leveldb.cpp:183] Compacted db in 13.143547ms
> I0623 13:29:05.972281 11026 leveldb.cpp:198] Created db iterator in 7492ns
> I0623 13:29:05.972537 11026 leveldb.cpp:204] Seeked to beginning of db in
> 2043ns
> I0623 13:29:05.972823 11026 leveldb.cpp:273] Iterated through 0 keys in the
> db in 817ns
> I0623 13:29:05.973098 11026 replica.cpp:741] Replica recovered with log
> positions 0 -> 0 with 1 holes and 0 unlearned
> I0623 13:29:05.973688 11050 recover.cpp:425] Starting replica recovery
> I0623 13:29:05.973769 11050 recover.cpp:451] Replica is in EMPTY status
> I0623 13:29:05.974089 11050 replica.cpp:638] Replica in EMPTY status received
> a broadcasted recover request
> I0623 13:29:05.974153 11050 recover.cpp:188] Received a recover response from
> a replica in EMPTY status
> I0623 13:29:05.974290 11050 recover.cpp:542] Updating replica status to
> STARTING
> I0623 13:29:05.978360 11047 master.cpp:288] Master
> 20140623-132905-16842879-46830-11026 (quantal) started on 127.0.1.1:46830
> I0623 13:29:05.978400 11047 master.cpp:325] Master only allowing
> authenticated frameworks to register
> I0623 13:29:05.978409 11047 master.cpp:330] Master only allowing
> authenticated slaves to register
> I0623 13:29:05.978415 11047 credentials.hpp:35] Loading credentials for
> authentication from '/tmp/HealthCheckTest_HealthyTask_MOxO1V/credentials'
> I0623 13:29:05.978492 11047 master.cpp:356] Authorization enabled
> I0623 13:29:05.978965 11047 hierarchical_allocator_process.hpp:301]
> Initializing hierarchical allocator process with master :
> [email protected]:46830
> I0623 13:29:05.979009 11047 master.cpp:122] No whitelist given. Advertising
> offers for all slaves
> I0623 13:29:05.979218 11047 master.cpp:1122] The newly elected leader is
> [email protected]:46830 with id 20140623-132905-16842879-46830-11026
> I0623 13:29:05.979240 11047 master.cpp:1135] Elected as the leading master!
> I0623 13:29:05.979249 11047 master.cpp:953] Recovering from registrar
> I0623 13:29:05.979318 11047 registrar.cpp:313] Recovering registrar
> I0623 13:29:05.987046 11050 leveldb.cpp:306] Persisting metadata (8 bytes) to
> leveldb took 12.683367ms
> I0623 13:29:05.987083 11050 replica.cpp:320] Persisted replica status to
> STARTING
> I0623 13:29:05.987197 11050 recover.cpp:451] Replica is in STARTING status
> I0623 13:29:05.987592 11050 replica.cpp:638] Replica in STARTING status
> received a broadcasted recover request
> I0623 13:29:05.987668 11050 recover.cpp:188] Received a recover response from
> a replica in STARTING status
> I0623 13:29:05.987797 11050 recover.cpp:542] Updating replica status to VOTING
> I0623 13:29:05.998905 11050 leveldb.cpp:306] Persisting metadata (8 bytes) to
> leveldb took 11.033964ms
> I0623 13:29:05.998955 11050 replica.cpp:320] Persisted replica status to
> VOTING
> I0623 13:29:05.999232 11048 recover.cpp:556] Successfully joined the Paxos
> group
> I0623 13:29:05.999614 11050 recover.cpp:440] Recover process terminated
> I0623 13:29:05.999821 11050 log.cpp:656] Attempting to start the writer
> I0623 13:29:06.000411 11050 replica.cpp:474] Replica received implicit
> promise request with proposal 1
> I0623 13:29:06.011952 11050 leveldb.cpp:306] Persisting metadata (8 bytes) to
> leveldb took 11.138872ms
> I0623 13:29:06.012461 11050 replica.cpp:342] Persisted promised to 1
> I0623 13:29:06.016896 11045 coordinator.cpp:230] Coordinator attemping to
> fill missing position
> I0623 13:29:06.017344 11045 replica.cpp:375] Replica received explicit
> promise request for position 0 with proposal 2
> I0623 13:29:06.027925 11045 leveldb.cpp:343] Persisting action (8 bytes) to
> leveldb took 10.554554ms
> I0623 13:29:06.027961 11045 replica.cpp:676] Persisted action at 0
> I0623 13:29:06.028323 11045 replica.cpp:508] Replica received write request
> for position 0
> I0623 13:29:06.028357 11045 leveldb.cpp:438] Reading position from leveldb
> took 16343ns
> I0623 13:29:06.038075 11045 leveldb.cpp:343] Persisting action (14 bytes) to
> leveldb took 9.692828ms
> I0623 13:29:06.038537 11045 replica.cpp:676] Persisted action at 0
> I0623 13:29:06.044852 11048 replica.cpp:655] Replica received learned notice
> for position 0
> I0623 13:29:06.054749 11048 leveldb.cpp:343] Persisting action (16 bytes) to
> leveldb took 9.86323ms
> I0623 13:29:06.054788 11048 replica.cpp:676] Persisted action at 0
> I0623 13:29:06.054800 11048 replica.cpp:661] Replica learned NOP action at
> position 0
> I0623 13:29:06.055058 11048 log.cpp:672] Writer started with ending position 0
> I0623 13:29:06.055423 11048 leveldb.cpp:438] Reading position from leveldb
> took 18568ns
> I0623 13:29:06.056553 11048 registrar.cpp:346] Successfully fetched the
> registry (0B)
> I0623 13:29:06.056581 11048 registrar.cpp:422] Attempting to update the
> 'registry'
> I0623 13:29:06.057991 11045 log.cpp:680] Attempting to append 120 bytes to
> the log
> I0623 13:29:06.058054 11045 coordinator.cpp:340] Coordinator attempting to
> write APPEND action at position 1
> I0623 13:29:06.058347 11045 replica.cpp:508] Replica received write request
> for position 1
> I0623 13:29:06.068114 11045 leveldb.cpp:343] Persisting action (137 bytes) to
> leveldb took 9.741464ms
> I0623 13:29:06.068155 11045 replica.cpp:676] Persisted action at 1
> I0623 13:29:06.068431 11045 replica.cpp:655] Replica received learned notice
> for position 1
> I0623 13:29:06.079959 11045 leveldb.cpp:343] Persisting action (139 bytes) to
> leveldb took 11.501635ms
> I0623 13:29:06.080003 11045 replica.cpp:676] Persisted action at 1
> I0623 13:29:06.080014 11045 replica.cpp:661] Replica learned APPEND action at
> position 1
> I0623 13:29:06.080891 11045 registrar.cpp:479] Successfully updated 'registry'
> I0623 13:29:06.081310 11045 registrar.cpp:372] Successfully recovered
> registrar
> I0623 13:29:06.081625 11045 log.cpp:699] Attempting to truncate the log to 1
> I0623 13:29:06.082010 11045 master.cpp:980] Recovered 0 slaves from the
> Registry (84B) ; allowing 10mins for slaves to re-register
> I0623 13:29:06.082386 11045 coordinator.cpp:340] Coordinator attempting to
> write TRUNCATE action at position 2
> I0623 13:29:06.083796 11026 mesos_containerizer.cpp:125] Using isolation:
> posix/cpu,posix/mem
> I0623 13:29:06.086760 11045 slave.cpp:168] Slave started on
> 162)@127.0.1.1:46830
> I0623 13:29:06.087103 11045 credentials.hpp:35] Loading credentials for
> authentication from '/tmp/HealthCheckTest_HealthyTask_8Tzxpu/credential'
> I0623 13:29:06.087458 11045 slave.cpp:268] Slave using credential for:
> test-principal
> I0623 13:29:06.087806 11045 slave.cpp:281] Slave resources: cpus(*):2;
> mem(*):1024; disk(*):1024; ports(*):[31000-32000]
> I0623 13:29:06.088110 11045 slave.cpp:309] Slave hostname: quantal
> I0623 13:29:06.088420 11045 slave.cpp:310] Slave checkpoint: false
> I0623 13:29:06.089365 11049 state.cpp:33] Recovering state from
> '/tmp/HealthCheckTest_HealthyTask_8Tzxpu/meta'
> I0623 13:29:06.089573 11049 status_update_manager.cpp:193] Recovering status
> update manager
> I0623 13:29:06.089628 11049 replica.cpp:508] Replica received write request
> for position 2
> I0623 13:29:06.089810 11052 mesos_containerizer.cpp:283] Recovering
> containerizer
> I0623 13:29:06.090075 11052 slave.cpp:3110] Finished recovery
> I0623 13:29:06.090356 11052 slave.cpp:584] New master detected at
> [email protected]:46830
> I0623 13:29:06.090400 11052 slave.cpp:660] Authenticating with master
> [email protected]:46830
> I0623 13:29:06.090451 11052 slave.cpp:633] Detecting new master
> I0623 13:29:06.090489 11052 status_update_manager.cpp:167] New master
> detected at [email protected]:46830
> I0623 13:29:06.090528 11052 authenticatee.hpp:128] Creating new client SASL
> connection
> I0623 13:29:06.090682 11052 master.cpp:3499] Authenticating
> slave(162)@127.0.1.1:46830
> I0623 13:29:06.090781 11052 authenticator.hpp:156] Creating new server SASL
> connection
> I0623 13:29:06.090888 11052 authenticatee.hpp:219] Received SASL
> authentication mechanisms: CRAM-MD5
> I0623 13:29:06.090909 11052 authenticatee.hpp:245] Attempting to authenticate
> with mechanism 'CRAM-MD5'
> I0623 13:29:06.090934 11052 authenticator.hpp:262] Received SASL
> authentication start
> I0623 13:29:06.090967 11052 authenticator.hpp:384] Authentication requires
> more steps
> I0623 13:29:06.090994 11052 authenticatee.hpp:265] Received SASL
> authentication step
> I0623 13:29:06.091032 11052 authenticator.hpp:290] Received SASL
> authentication step
> I0623 13:29:06.091048 11052 auxprop.cpp:81] Request to lookup properties for
> user: 'test-principal' realm: 'quantal' server FQDN: 'quantal'
> SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false
> SASL_AUXPROP_AUTHZID: false
> I0623 13:29:06.091055 11052 auxprop.cpp:153] Looking up auxiliary property
> '*userPassword'
> I0623 13:29:06.091066 11052 auxprop.cpp:153] Looking up auxiliary property
> '*cmusaslsecretCRAM-MD5'
> I0623 13:29:06.091075 11052 auxprop.cpp:81] Request to lookup properties for
> user: 'test-principal' realm: 'quantal' server FQDN: 'quantal'
> SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false
> SASL_AUXPROP_AUTHZID: true
> I0623 13:29:06.091081 11052 auxprop.cpp:103] Skipping auxiliary property
> '*userPassword' since SASL_AUXPROP_AUTHZID == true
> I0623 13:29:06.091086 11052 auxprop.cpp:103] Skipping auxiliary property
> '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
> I0623 13:29:06.091096 11052 authenticator.hpp:376] Authentication success
> I0623 13:29:06.091125 11052 authenticatee.hpp:305] Authentication success
> I0623 13:29:06.091150 11052 master.cpp:3539] Successfully authenticated
> principal 'test-principal' at slave(162)@127.0.1.1:46830
> I0623 13:29:06.091261 11052 slave.cpp:717] Successfully authenticated with
> master [email protected]:46830
> I0623 13:29:06.091310 11052 slave.cpp:955] Will retry registration in
> 4.490367ms if necessary
> I0623 13:29:06.091405 11046 master.cpp:2781] Registering slave at
> slave(162)@127.0.1.1:46830 (quantal) with id
> 20140623-132905-16842879-46830-11026-0
> I0623 13:29:06.091518 11046 registrar.cpp:422] Attempting to update the
> 'registry'
> I0623 13:29:06.095747 11026 sched.cpp:139] Version: 0.20.0
> I0623 13:29:06.096346 11047 sched.cpp:235] New master detected at
> [email protected]:46830
> I0623 13:29:06.096371 11047 sched.cpp:285] Authenticating with master
> [email protected]:46830
> I0623 13:29:06.096462 11047 authenticatee.hpp:128] Creating new client SASL
> connection
> I0623 13:29:06.096894 11048 slave.cpp:955] Will retry registration in
> 31.550502ms if necessary
> I0623 13:29:06.097097 11047 master.cpp:3499] Authenticating
> [email protected]:46830
> I0623 13:29:06.097558 11046 authenticator.hpp:156] Creating new server SASL
> connection
> I0623 13:29:06.097673 11046 authenticatee.hpp:219] Received SASL
> authentication mechanisms: CRAM-MD5
> I0623 13:29:06.097692 11046 authenticatee.hpp:245] Attempting to authenticate
> with mechanism 'CRAM-MD5'
> I0623 13:29:06.097717 11046 authenticator.hpp:262] Received SASL
> authentication start
> I0623 13:29:06.097748 11046 authenticator.hpp:384] Authentication requires
> more steps
> I0623 13:29:06.097774 11046 authenticatee.hpp:265] Received SASL
> authentication step
> I0623 13:29:06.097807 11046 authenticator.hpp:290] Received SASL
> authentication step
> I0623 13:29:06.097823 11046 auxprop.cpp:81] Request to lookup properties for
> user: 'test-principal' realm: 'quantal' server FQDN: 'quantal'
> SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false
> SASL_AUXPROP_AUTHZID: false
> I0623 13:29:06.097831 11046 auxprop.cpp:153] Looking up auxiliary property
> '*userPassword'
> I0623 13:29:06.097841 11046 auxprop.cpp:153] Looking up auxiliary property
> '*cmusaslsecretCRAM-MD5'
> I0623 13:29:06.097849 11046 auxprop.cpp:81] Request to lookup properties for
> user: 'test-principal' realm: 'quantal' server FQDN: 'quantal'
> SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false
> SASL_AUXPROP_AUTHZID: true
> I0623 13:29:06.097856 11046 auxprop.cpp:103] Skipping auxiliary property
> '*userPassword' since SASL_AUXPROP_AUTHZID == true
> I0623 13:29:06.097861 11046 auxprop.cpp:103] Skipping auxiliary property
> '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
> I0623 13:29:06.097870 11046 authenticator.hpp:376] Authentication success
> I0623 13:29:06.097892 11046 authenticatee.hpp:305] Authentication success
> I0623 13:29:06.097942 11046 sched.cpp:359] Successfully authenticated with
> master [email protected]:46830
> I0623 13:29:06.097956 11046 sched.cpp:478] Sending registration request to
> [email protected]:46830
> I0623 13:29:06.098467 11047 master.cpp:2769] Ignoring register slave message
> from slave(162)@127.0.1.1:46830 (quantal) as admission is already in progress
> I0623 13:29:06.098753 11047 master.cpp:1233] Queuing up registration request
> from [email protected]:46830 because
> authentication is still in progress
> I0623 13:29:06.099154 11047 master.cpp:3539] Successfully authenticated
> principal 'test-principal' at
> [email protected]:46830
> I0623 13:29:06.103518 11049 leveldb.cpp:343] Persisting action (16 bytes) to
> leveldb took 13.860392ms
> I0623 13:29:06.103555 11049 replica.cpp:676] Persisted action at 2
> I0623 13:29:06.103824 11049 replica.cpp:655] Replica received learned notice
> for position 2
> I0623 13:29:06.104375 11047 master.cpp:1241] Received registration request
> from [email protected]:46830
> I0623 13:29:06.104627 11047 master.cpp:1201] Authorizing framework principal
> 'test-principal' to receive offers for role '*'
> I0623 13:29:06.104964 11047 master.cpp:1300] Registering framework
> 20140623-132905-16842879-46830-11026-0000 at
> [email protected]:46830
> I0623 13:29:06.105402 11047 sched.cpp:409] Framework registered with
> 20140623-132905-16842879-46830-11026-0000
> I0623 13:29:06.105834 11047 sched.cpp:423] Scheduler::registered took 15480ns
> I0623 13:29:06.105599 11048 hierarchical_allocator_process.hpp:331] Added
> framework 20140623-132905-16842879-46830-11026-0000
> I0623 13:29:06.106120 11048 hierarchical_allocator_process.hpp:724] No
> resources available to allocate!
> I0623 13:29:06.106132 11048 hierarchical_allocator_process.hpp:686] Performed
> allocation for 0 slaves in 16487ns
> I0623 13:29:06.116317 11049 leveldb.cpp:343] Persisting action (18 bytes) to
> leveldb took 12.466174ms
> I0623 13:29:06.116390 11049 leveldb.cpp:401] Deleting ~1 keys from leveldb
> took 37305ns
> I0623 13:29:06.116406 11049 replica.cpp:676] Persisted action at 2
> I0623 13:29:06.116417 11049 replica.cpp:661] Replica learned TRUNCATE action
> at position 2
> I0623 13:29:06.116758 11049 log.cpp:680] Attempting to append 295 bytes to
> the log
> I0623 13:29:06.116817 11049 coordinator.cpp:340] Coordinator attempting to
> write APPEND action at position 3
> I0623 13:29:06.117074 11049 replica.cpp:508] Replica received write request
> for position 3
> I0623 13:29:06.129529 11047 slave.cpp:955] Will retry registration in
> 3.448659ms if necessary
> I0623 13:29:06.129727 11048 master.cpp:2769] Ignoring register slave message
> from slave(162)@127.0.1.1:46830 (quantal) as admission is already in progress
> I0623 13:29:06.130036 11049 leveldb.cpp:343] Persisting action (314 bytes) to
> leveldb took 12.939545ms
> I0623 13:29:06.130332 11049 replica.cpp:676] Persisted action at 3
> I0623 13:29:06.130928 11045 replica.cpp:655] Replica received learned notice
> for position 3
> I0623 13:29:06.133996 11051 slave.cpp:955] Will retry registration in
> 153.139616ms if necessary
> I0623 13:29:06.134066 11051 master.cpp:2769] Ignoring register slave message
> from slave(162)@127.0.1.1:46830 (quantal) as admission is already in progress
> I0623 13:29:06.139631 11045 leveldb.cpp:343] Persisting action (316 bytes) to
> leveldb took 8.674286ms
> I0623 13:29:06.139662 11045 replica.cpp:676] Persisted action at 3
> I0623 13:29:06.139670 11045 replica.cpp:661] Replica learned APPEND action at
> position 3
> I0623 13:29:06.140383 11045 registrar.cpp:479] Successfully updated 'registry'
> I0623 13:29:06.140482 11045 log.cpp:699] Attempting to truncate the log to 3
> I0623 13:29:06.140555 11045 master.cpp:2821] Registered slave
> 20140623-132905-16842879-46830-11026-0 at slave(162)@127.0.1.1:46830 (quantal)
> I0623 13:29:06.140571 11045 master.cpp:3967] Adding slave
> 20140623-132905-16842879-46830-11026-0 at slave(162)@127.0.1.1:46830
> (quantal) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
> I0623 13:29:06.140727 11045 coordinator.cpp:340] Coordinator attempting to
> write TRUNCATE action at position 4
> I0623 13:29:06.140812 11045 slave.cpp:751] Registered with master
> [email protected]:46830; given slave ID 20140623-132905-16842879-46830-11026-0
> I0623 13:29:06.140887 11045 hierarchical_allocator_process.hpp:444] Added
> slave 20140623-132905-16842879-46830-11026-0 (quantal) with cpus(*):2;
> mem(*):1024; disk(*):1024; ports(*):[31000-32000] (and cpus(*):2;
> mem(*):1024; disk(*):1024; ports(*):[31000-32000] available)
> I0623 13:29:06.140946 11045 hierarchical_allocator_process.hpp:750] Offering
> cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] on slave
> 20140623-132905-16842879-46830-11026-0 to framework
> 20140623-132905-16842879-46830-11026-0000
> I0623 13:29:06.141038 11045 hierarchical_allocator_process.hpp:706] Performed
> allocation for slave 20140623-132905-16842879-46830-11026-0 in 120284ns
> I0623 13:29:06.141144 11045 master.hpp:794] Adding offer
> 20140623-132905-16842879-46830-11026-0 with resources cpus(*):2; mem(*):1024;
> disk(*):1024; ports(*):[31000-32000] on slave
> 20140623-132905-16842879-46830-11026-0 (quantal)
> I0623 13:29:06.141186 11045 master.cpp:3446] Sending 1 offers to framework
> 20140623-132905-16842879-46830-11026-0000
> I0623 13:29:06.141341 11045 sched.cpp:546] Scheduler::resourceOffers took
> 21190ns
> I0623 13:29:06.141527 11045 replica.cpp:508] Replica received write request
> for position 4
> I0623 13:29:06.142268 11051 master.hpp:804] Removing offer
> 20140623-132905-16842879-46830-11026-0 with resources cpus(*):2; mem(*):1024;
> disk(*):1024; ports(*):[31000-32000] on slave
> 20140623-132905-16842879-46830-11026-0 (quantal)
> I0623 13:29:06.142333 11051 master.cpp:2125] Processing reply for offers: [
> 20140623-132905-16842879-46830-11026-0 ] on slave
> 20140623-132905-16842879-46830-11026-0 at slave(162)@127.0.1.1:46830
> (quantal) for framework 20140623-132905-16842879-46830-11026-0000
> I0623 13:29:06.142364 11051 master.cpp:2211] Authorizing framework principal
> 'test-principal' to launch task 1 as user 'jenkins'
> I0623 13:29:06.142791 11051 master.hpp:766] Adding task 1 with resources
> cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] on slave
> 20140623-132905-16842879-46830-11026-0 (quantal)
> I0623 13:29:06.142828 11051 master.cpp:2277] Launching task 1 of framework
> 20140623-132905-16842879-46830-11026-0000 with resources cpus(*):2;
> mem(*):1024; disk(*):1024; ports(*):[31000-32000] on slave
> 20140623-132905-16842879-46830-11026-0 at slave(162)@127.0.1.1:46830 (quantal)
> I0623 13:29:06.142963 11051 slave.cpp:986] Got assigned task 1 for framework
> 20140623-132905-16842879-46830-11026-0000
> I0623 13:29:06.143211 11051 slave.cpp:1096] Launching task 1 for framework
> 20140623-132905-16842879-46830-11026-0000
> I0623 13:29:06.144738 11046 mesos_containerizer.cpp:548] Starting container
> '1045d906-8cec-476d-a2a1-947e61983a5b' for executor '1' of framework
> '20140623-132905-16842879-46830-11026-0000'
> I0623 13:29:06.147037 11046 launcher.cpp:117] Forked child with pid '12559'
> for container '1045d906-8cec-476d-a2a1-947e61983a5b'
> I0623 13:29:06.148129 11046 mesos_containerizer.cpp:658] Fetching URIs for
> container '1045d906-8cec-476d-a2a1-947e61983a5b' using command
> '/var/jenkins/workspace/mesos-ubuntu-12.10-gcc/src/mesos-fetcher'
> I0623 13:29:06.150723 11051 slave.cpp:1206] Queuing task '1' for executor 1
> of framework '20140623-132905-16842879-46830-11026-0000
> I0623 13:29:06.151619 11051 slave.cpp:545] Successfully attached file
> '/tmp/HealthCheckTest_HealthyTask_8Tzxpu/slaves/20140623-132905-16842879-46830-11026-0/frameworks/20140623-132905-16842879-46830-11026-0000/executors/1/runs/1045d906-8cec-476d-a2a1-947e61983a5b'
> I0623 13:29:06.158108 11045 leveldb.cpp:343] Persisting action (16 bytes) to
> leveldb took 16.477988ms
> I0623 13:29:06.158176 11045 replica.cpp:676] Persisted action at 4
> I0623 13:29:06.158668 11045 replica.cpp:655] Replica received learned notice
> for position 4
> I0623 13:29:06.168743 11045 leveldb.cpp:343] Persisting action (18 bytes) to
> leveldb took 10.019524ms
> I0623 13:29:06.168838 11045 leveldb.cpp:401] Deleting ~2 keys from leveldb
> took 43708ns
> I0623 13:29:06.168860 11045 replica.cpp:676] Persisted action at 4
> I0623 13:29:06.168874 11045 replica.cpp:661] Replica learned TRUNCATE action
> at position 4
> I0623 13:29:06.903492 11045 slave.cpp:2452] Monitoring executor '1' of
> framework '20140623-132905-16842879-46830-11026-0000' in container
> '1045d906-8cec-476d-a2a1-947e61983a5b'
> I0623 13:29:06.953822 11049 slave.cpp:1717] Got registration for executor '1'
> of framework 20140623-132905-16842879-46830-11026-0000
> I0623 13:29:06.956344 11053 process.cpp:1098] Socket closed while receiving
> I0623 13:29:06.958034 11049 slave.cpp:1836] Flushing queued task 1 for
> executor '1' of framework 20140623-132905-16842879-46830-11026-0000
> I0623 13:29:06.958570 11053 process.cpp:1098] Socket closed while receiving
> I0623 13:29:06.965090 11051 slave.cpp:2071] Handling status update
> TASK_RUNNING (UUID: 0f48b057-84bb-4622-8abc-fa28a67d1faa) for task 1 of
> framework 20140623-132905-16842879-46830-11026-0000 from
> executor(1)@127.0.1.1:60351
> I0623 13:29:06.965258 11051 status_update_manager.cpp:320] Received status
> update TASK_RUNNING (UUID: 0f48b057-84bb-4622-8abc-fa28a67d1faa) for task 1
> of framework 20140623-132905-16842879-46830-11026-0000
> I0623 13:29:06.965276 11051 status_update_manager.cpp:499] Creating
> StatusUpdate stream for task 1 of framework
> 20140623-132905-16842879-46830-11026-0000
> I0623 13:29:06.965415 11051 status_update_manager.cpp:373] Forwarding status
> update TASK_RUNNING (UUID: 0f48b057-84bb-4622-8abc-fa28a67d1faa) for task 1
> of framework 20140623-132905-16842879-46830-11026-0000 to
> [email protected]:46830
> I0623 13:29:06.965626 11051 master.cpp:3107] Status update TASK_RUNNING
> (UUID: 0f48b057-84bb-4622-8abc-fa28a67d1faa) for task 1 of framework
> 20140623-132905-16842879-46830-11026-0000 from slave
> 20140623-132905-16842879-46830-11026-0 at slave(162)@127.0.1.1:46830 (quantal)
> I0623 13:29:06.965668 11051 slave.cpp:2229] Status update manager
> successfully handled status update TASK_RUNNING (UUID:
> 0f48b057-84bb-4622-8abc-fa28a67d1faa) for task 1 of framework
> 20140623-132905-16842879-46830-11026-0000
> I0623 13:29:06.965679 11051 slave.cpp:2235] Sending acknowledgement for
> status update TASK_RUNNING (UUID: 0f48b057-84bb-4622-8abc-fa28a67d1faa) for
> task 1 of framework 20140623-132905-16842879-46830-11026-0000 to
> executor(1)@127.0.1.1:60351
> I0623 13:29:06.965945 11051 sched.cpp:637] Scheduler::statusUpdate took
> 45619ns
> I0623 13:29:06.966094 11051 master.cpp:2631] Forwarding status update
> acknowledgement 0f48b057-84bb-4622-8abc-fa28a67d1faa for task 1 of framework
> 20140623-132905-16842879-46830-11026-0000 to slave
> 20140623-132905-16842879-46830-11026-0 at slave(162)@127.0.1.1:46830 (quantal)
> I0623 13:29:06.966984 11053 process.cpp:1098] Socket closed while receiving
> I0623 13:29:06.967305 11050 status_update_manager.cpp:398] Received status
> update acknowledgement (UUID: 0f48b057-84bb-4622-8abc-fa28a67d1faa) for task
> 1 of framework 20140623-132905-16842879-46830-11026-0000
> I0623 13:29:06.967434 11050 slave.cpp:1657] Status update manager
> successfully handled status update acknowledgement (UUID:
> 0f48b057-84bb-4622-8abc-fa28a67d1faa) for task 1 of framework
> 20140623-132905-16842879-46830-11026-0000
> I0623 13:29:06.979565 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 77364ns
> I0623 13:29:07.980064 11052 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 84425ns
> I0623 13:29:08.980820 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 41035ns
> I0623 13:29:09.984819 11049 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 44099ns
> I0623 13:29:10.979605 11049 master.cpp:122] No whitelist given. Advertising
> offers for all slaves
> I0623 13:29:10.986023 11045 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 34630ns
> I0623 13:29:11.986449 11046 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 42464ns
> I0623 13:29:12.987354 11051 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 43441ns
> I0623 13:29:13.988312 11045 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 43495ns
> I0623 13:29:14.989270 11052 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 42945ns
> I0623 13:29:15.979938 11045 master.cpp:122] No whitelist given. Advertising
> offers for all slaves
> I0623 13:29:15.989708 11045 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 50353ns
> tests/health_check_tests.cpp:159: Failure
> Failed to wait 10secs for statusHealth
> I0623 13:29:16.990399 11051 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 43532ns
> I0623 13:29:17.991320 11049 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 51967ns
> I0623 13:29:18.992204 11051 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 60190ns
> I0623 13:29:19.993016 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 54574ns
> I0623 13:29:20.981199 11047 master.cpp:122] No whitelist given. Advertising
> offers for all slaves
> I0623 13:29:20.993456 11047 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 47786ns
> I0623 13:29:21.994848 11049 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 55818ns
> I0623 13:29:22.995617 11051 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 52831ns
> I0623 13:29:23.996482 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 54658ns
> I0623 13:29:24.997186 11047 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 52690ns
> I0623 13:29:25.982275 11052 master.cpp:122] No whitelist given. Advertising
> offers for all slaves
> I0623 13:29:25.997391 11052 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 49323ns
> I0623 13:29:26.973814 11045 slave.cpp:2071] Handling status update
> TASK_FINISHED (UUID: 3c926ce6-fbf9-4aef-b8e5-db6c51f92110) for task 1 of
> framework 20140623-132905-16842879-46830-11026-0000 from
> executor(1)@127.0.1.1:60351
> I0623 13:29:26.973901 11045 slave.cpp:3752] Terminating task 1
> I0623 13:29:26.974519 11045 status_update_manager.cpp:320] Received status
> update TASK_FINISHED (UUID: 3c926ce6-fbf9-4aef-b8e5-db6c51f92110) for task 1
> of framework 20140623-132905-16842879-46830-11026-0000
> I0623 13:29:26.974581 11045 status_update_manager.cpp:373] Forwarding status
> update TASK_FINISHED (UUID: 3c926ce6-fbf9-4aef-b8e5-db6c51f92110) for task 1
> of framework 20140623-132905-16842879-46830-11026-0000 to
> [email protected]:46830
> I0623 13:29:26.974784 11045 master.cpp:3107] Status update TASK_FINISHED
> (UUID: 3c926ce6-fbf9-4aef-b8e5-db6c51f92110) for task 1 of framework
> 20140623-132905-16842879-46830-11026-0000 from slave
> 20140623-132905-16842879-46830-11026-0 at slave(162)@127.0.1.1:46830 (quantal)
> I0623 13:29:26.974872 11045 master.hpp:784] Removing task 1 with resources
> cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] on slave
> 20140623-132905-16842879-46830-11026-0 (quantal)
> I0623 13:29:26.975059 11045 slave.cpp:2229] Status update manager
> successfully handled status update TASK_FINISHED (UUID:
> 3c926ce6-fbf9-4aef-b8e5-db6c51f92110) for task 1 of framework
> 20140623-132905-16842879-46830-11026-0000
> I0623 13:29:26.975075 11045 slave.cpp:2235] Sending acknowledgement for
> status update TASK_FINISHED (UUID: 3c926ce6-fbf9-4aef-b8e5-db6c51f92110) for
> task 1 of framework 20140623-132905-16842879-46830-11026-0000 to
> executor(1)@127.0.1.1:60351
> I0623 13:29:26.975688 11051 sched.cpp:637] Scheduler::statusUpdate took
> 41150ns
> I0623 13:29:26.975805 11051 hierarchical_allocator_process.hpp:635] Recovered
> cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (total
> allocatable: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]) on
> slave 20140623-132905-16842879-46830-11026-0 from framework
> 20140623-132905-16842879-46830-11026-0000
> I0623 13:29:26.976025 11050 master.cpp:2631] Forwarding status update
> acknowledgement 3c926ce6-fbf9-4aef-b8e5-db6c51f92110 for task 1 of framework
> 20140623-132905-16842879-46830-11026-0000 to slave
> 20140623-132905-16842879-46830-11026-0 at slave(162)@127.0.1.1:46830 (quantal)
> I0623 13:29:26.976826 11053 process.cpp:1098] Socket closed while receiving
> I0623 13:29:26.981264 11046 status_update_manager.cpp:398] Received status
> update acknowledgement (UUID: 3c926ce6-fbf9-4aef-b8e5-db6c51f92110) for task
> 1 of framework 20140623-132905-16842879-46830-11026-0000
> I0623 13:29:26.981313 11046 status_update_manager.cpp:530] Cleaning up status
> update stream for task 1 of framework
> 20140623-132905-16842879-46830-11026-0000
> I0623 13:29:26.981657 11045 slave.cpp:1657] Status update manager
> successfully handled status update acknowledgement (UUID:
> 3c926ce6-fbf9-4aef-b8e5-db6c51f92110) for task 1 of framework
> 20140623-132905-16842879-46830-11026-0000
> I0623 13:29:26.982151 11045 slave.cpp:3794] Completing task 1
> I0623 13:29:26.998436 11050 hierarchical_allocator_process.hpp:750] Offering
> cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] on slave
> 20140623-132905-16842879-46830-11026-0 to framework
> 20140623-132905-16842879-46830-11026-0000
> I0623 13:29:26.998576 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 206661ns
> I0623 13:29:26.998669 11050 master.hpp:794] Adding offer
> 20140623-132905-16842879-46830-11026-1 with resources cpus(*):2; mem(*):1024;
> disk(*):1024; ports(*):[31000-32000] on slave
> 20140623-132905-16842879-46830-11026-0 (quantal)
> I0623 13:29:26.998721 11050 master.cpp:3446] Sending 1 offers to framework
> 20140623-132905-16842879-46830-11026-0000
> I0623 13:29:26.998901 11050 sched.cpp:546] Scheduler::resourceOffers took
> 37165ns
> I0623 13:29:27.974091 11053 process.cpp:1037] Socket closed while receiving
> I0623 13:29:27.999688 11045 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 53454ns
> I0623 13:29:28.915324 11046 mesos_containerizer.cpp:1131] Executor for
> container '1045d906-8cec-476d-a2a1-947e61983a5b' has exited
> I0623 13:29:28.915392 11046 mesos_containerizer.cpp:1015] Destroying
> container '1045d906-8cec-476d-a2a1-947e61983a5b'
> I0623 13:29:28.927748 11045 slave.cpp:2510] Executor '1' of framework
> 20140623-132905-16842879-46830-11026-0000 exited with status 0
> I0623 13:29:28.927831 11045 slave.cpp:2644] Cleaning up executor '1' of
> framework 20140623-132905-16842879-46830-11026-0000
> I0623 13:29:28.928016 11045 slave.cpp:2719] Cleaning up framework
> 20140623-132905-16842879-46830-11026-0000
> I0623 13:29:28.928153 11045 gc.cpp:56] Scheduling
> '/tmp/HealthCheckTest_HealthyTask_8Tzxpu/slaves/20140623-132905-16842879-46830-11026-0/frameworks/20140623-132905-16842879-46830-11026-0000/executors/1/runs/1045d906-8cec-476d-a2a1-947e61983a5b'
> for gc 6.99998926017185days in the future
> I0623 13:29:28.928225 11045 gc.cpp:56] Scheduling
> '/tmp/HealthCheckTest_HealthyTask_8Tzxpu/slaves/20140623-132905-16842879-46830-11026-0/frameworks/20140623-132905-16842879-46830-11026-0000/executors/1'
> for gc 6.99998925930667days in the future
> I0623 13:29:28.928268 11045 gc.cpp:56] Scheduling
> '/tmp/HealthCheckTest_HealthyTask_8Tzxpu/slaves/20140623-132905-16842879-46830-11026-0/frameworks/20140623-132905-16842879-46830-11026-0000'
> for gc 6.99998925861037days in the future
> I0623 13:29:28.928308 11045 status_update_manager.cpp:282] Closing status
> update streams for framework 20140623-132905-16842879-46830-11026-0000
> I0623 13:29:29.000550 11045 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 50434ns
> I0623 13:29:30.001346 11045 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 53577ns
> I0623 13:29:30.982919 11050 master.cpp:122] No whitelist given. Advertising
> offers for all slaves
> I0623 13:29:31.002223 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 51750ns
> I0623 13:29:32.002712 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 73773ns
> I0623 13:29:33.003180 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 53940ns
> I0623 13:29:34.003808 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 53558ns
> I0623 13:29:35.004268 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 53898ns
> I0623 13:29:35.983779 11050 master.cpp:122] No whitelist given. Advertising
> offers for all slaves
> I0623 13:29:36.005245 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 51824ns
> I0623 13:29:37.005506 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 53274ns
> I0623 13:29:38.005902 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 43625ns
> I0623 13:29:39.006609 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 58328ns
> I0623 13:29:40.007002 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 53416ns
> I0623 13:29:40.984532 11050 master.cpp:122] No whitelist given. Advertising
> offers for all slaves
> I0623 13:29:41.008054 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 53937ns
> I0623 13:29:42.008424 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 58434ns
> I0623 13:29:43.008923 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 55446ns
> I0623 13:29:44.009263 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 76356ns
> I0623 13:29:45.009577 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 54392ns
> I0623 13:29:45.985028 11050 master.cpp:122] No whitelist given. Advertising
> offers for all slaves
> I0623 13:29:46.010452 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 54094ns
> I0623 13:29:47.010826 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 55739ns
> I0623 13:29:48.011225 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 56030ns
> I0623 13:29:49.011993 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 53974ns
> I0623 13:29:50.012663 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 83039ns
> I0623 13:29:50.986024 11050 master.cpp:122] No whitelist given. Advertising
> offers for all slaves
> I0623 13:29:51.013417 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 55998ns
> I0623 13:29:52.014410 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 66513ns
> I0623 13:29:53.014827 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 54592ns
> I0623 13:29:54.015296 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 52885ns
> I0623 13:29:55.015703 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 53916ns
> I0623 13:29:55.987176 11050 master.cpp:122] No whitelist given. Advertising
> offers for all slaves
> I0623 13:29:56.016623 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 52742ns
> I0623 13:29:57.016999 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 62540ns
> I0623 13:29:58.017364 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 43176ns
> I0623 13:29:59.017732 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 53975ns
> I0623 13:30:00.018108 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 53350ns
> I0623 13:30:00.987377 11050 master.cpp:122] No whitelist given. Advertising
> offers for all slaves
> I0623 13:30:01.018800 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 52418ns
> I0623 13:30:02.019189 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 53547ns
> I0623 13:30:03.019587 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 54179ns
> I0623 13:30:04.019919 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 52882ns
> I0623 13:30:05.020361 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 52947ns
> I0623 13:30:05.988178 11050 master.cpp:122] No whitelist given. Advertising
> offers for all slaves
> I0623 13:30:06.021682 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 56257ns
> I0623 13:30:06.090155 11050 slave.cpp:2965] Current usage 74.04%. Max allowed
> age: 1.117428832185220days
> I0623 13:30:06.150583 11050 slave.cpp:2881] Framework
> 20140623-132905-16842879-46830-11026-0000 seems to have exited. Ignoring
> registration timeout for executor '1'
> I0623 13:30:07.022019 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 53318ns
> I0623 13:30:08.022624 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 54292ns
> I0623 13:30:09.023293 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 53542ns
> I0623 13:30:10.023941 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 52393ns
> I0623 13:30:10.989413 11050 master.cpp:122] No whitelist given. Advertising
> offers for all slaves
> I0623 13:30:11.024899 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 52966ns
> I0623 13:30:12.025527 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 53140ns
> I0623 13:30:13.026146 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 53721ns
> I0623 13:30:14.026729 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 53274ns
> I0623 13:30:15.027339 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 54069ns
> I0623 13:30:15.989742 11050 master.cpp:122] No whitelist given. Advertising
> offers for all slaves
> I0623 13:30:16.028256 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 52569ns
> I0623 13:30:17.028873 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 53962ns
> I0623 13:30:18.029326 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 52644ns
> I0623 13:30:19.029984 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 54637ns
> I0623 13:30:20.030349 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 44872ns
> I0623 13:30:20.990906 11050 master.cpp:122] No whitelist given. Advertising
> offers for all slaves
> I0623 13:30:21.031368 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 54554ns
> I0623 13:30:22.032305 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 52795ns
> I0623 13:30:23.032912 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 54090ns
> I0623 13:30:24.033435 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 65308ns
> I0623 13:30:25.034030 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 54331ns
> I0623 13:30:25.991462 11050 master.cpp:122] No whitelist given. Advertising
> offers for all slaves
> I0623 13:30:26.034934 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 56338ns
> I0623 13:30:27.035320 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 54295ns
> I0623 13:30:28.035639 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 43351ns
> I0623 13:30:29.036260 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 53786ns
> I0623 13:30:30.036741 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 53673ns
> I0623 13:30:30.992256 11050 master.cpp:122] No whitelist given. Advertising
> offers for all slaves
> I0623 13:30:31.037739 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 51929ns
> I0623 13:30:32.038426 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 68657ns
> I0623 13:30:33.038898 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 53297ns
> I0623 13:30:34.039538 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 55770ns
> I0623 13:30:35.039994 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 53309ns
> I0623 13:30:35.993522 11050 master.cpp:122] No whitelist given. Advertising
> offers for all slaves
> I0623 13:30:36.041009 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 52201ns
> I0623 13:30:37.041970 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 53620ns
> I0623 13:30:38.042342 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 52384ns
> I0623 13:30:39.042762 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 53347ns
> I0623 13:30:40.043160 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 52846ns
> I0623 13:30:40.994627 11050 master.cpp:122] No whitelist given. Advertising
> offers for all slaves
> I0623 13:30:41.044037 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 55044ns
> I0623 13:30:42.044471 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 69351ns
> I0623 13:30:43.044844 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 52761ns
> I0623 13:30:44.045295 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 58272ns
> I0623 13:30:45.045703 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 53121ns
> I0623 13:30:45.995093 11050 master.cpp:122] No whitelist given. Advertising
> offers for all slaves
> I0623 13:30:46.046560 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 53568ns
> I0623 13:30:47.047122 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 53533ns
> I0623 13:30:48.047538 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 54903ns
> I0623 13:30:49.048111 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 54062ns
> I0623 13:30:50.048686 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 55433ns
> I0623 13:30:50.996052 11050 master.cpp:122] No whitelist given. Advertising
> offers for all slaves
> I0623 13:30:51.049459 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 53307ns
> I0623 13:30:52.049793 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 53253ns
> I0623 13:30:53.050050 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 53589ns
> I0623 13:30:54.050307 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 54237ns
> I0623 13:30:55.051612 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 55806ns
> I0623 13:30:55.996837 11050 master.cpp:122] No whitelist given. Advertising
> offers for all slaves
> I0623 13:30:56.052299 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 53773ns
> I0623 13:30:57.053175 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 43987ns
> I0623 13:30:58.054240 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 43877ns
> I0623 13:30:59.054507 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 42241ns
> I0623 13:31:00.054829 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 43142ns
> I0623 13:31:00.998021 11050 master.cpp:122] No whitelist given. Advertising
> offers for all slaves
> I0623 13:31:01.055660 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 53868ns
> I0623 13:31:02.056437 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 55486ns
> I0623 13:31:03.056727 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 53723ns
> I0623 13:31:04.056962 11050 hierarchical_allocator_process.hpp:686] Performed
> allocation for 1 slaves in 54088ns
> {noformat}
--
This message was sent by Atlassian JIRA
(v6.2#6252)
