You are viewing a plain text version of this content. The canonical link for it is here.
Posted to issues@mesos.apache.org by "Bernd Mathiske (JIRA)" <ji...@apache.org> on 2015/06/09 11:33:01 UTC

[jira] [Commented] (MESOS-2829) FetcherCacheTest.CachedFallback test is flaky

    [ https://issues.apache.org/jira/browse/MESOS-2829?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel&focusedCommentId=14578632#comment-14578632 ] 

Bernd Mathiske commented on MESOS-2829:
---------------------------------------

https://reviews.apache.org/r/35247/

> FetcherCacheTest.CachedFallback test is flaky
> ---------------------------------------------
>
>                 Key: MESOS-2829
>                 URL: https://issues.apache.org/jira/browse/MESOS-2829
>             Project: Mesos
>          Issue Type: Bug
>          Components: fetcher
>    Affects Versions: 0.23.0
>            Reporter: Vinod Kone
>            Assignee: Bernd Mathiske
>              Labels: flaky-test
>
> Observed this on internal CI
> {code}
> DEBUG: [ RUN      ] FetcherCacheTest.CachedFallback
> DEBUG: Using temporary directory '/tmp/FetcherCacheTest_CachedFallback_dmr8bH'
> DEBUG: I0608 08:32:39.091538 56580 leveldb.cpp:176] Opened db in 5.078136ms
> DEBUG: I0608 08:32:39.093271 56580 leveldb.cpp:183] Compacted db in 1.696938ms
> DEBUG: I0608 08:32:39.093312 56580 leveldb.cpp:198] Created db iterator in 5708ns
> DEBUG: I0608 08:32:39.093325 56580 leveldb.cpp:204] Seeked to beginning of db in 940ns
> DEBUG: I0608 08:32:39.093333 56580 leveldb.cpp:273] Iterated through 0 keys in the db in 270ns
> DEBUG: I0608 08:32:39.093353 56580 replica.cpp:744] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned
> DEBUG: I0608 08:32:39.093597 56613 recover.cpp:449] Starting replica recovery
> DEBUG: I0608 08:32:39.093706 56597 recover.cpp:475] Replica is in EMPTY status
> DEBUG: I0608 08:32:39.094511 56607 replica.cpp:641] Replica in EMPTY status received a broadcasted recover request
> DEBUG: I0608 08:32:39.094952 56606 recover.cpp:195] Received a recover response from a replica in EMPTY status
> DEBUG: I0608 08:32:39.095067 56606 recover.cpp:566] Updating replica status to STARTING
> DEBUG: I0608 08:32:39.095487 56598 master.cpp:363] Master 20150608-083239-1787367596-39187-56580 (<***redacted***>) started on <***redacted***>
> DEBUG: I0608 08:32:39.095510 56598 master.cpp:365] Flags at startup: --acls="" --allocation_interval="1secs" --allocator="HierarchicalDRF" --authenticate="true" --authenticate_slaves="true" --authenticators="crammd5" --credentials="/tmp/FetcherCacheTest_CachedFallback_dmr8bH/credentials" --framework_sorter="drf" --help="false" --initialize_driver_logging="true" --log_auto_initialize="true" --logbufsecs="0" --logging_level="INFO" --quiet="false" --recovery_slave_removal_limit="100%" --registry="replicated_log" --registry_fetch_timeout="1mins" --registry_store_timeout="25secs" --registry_strict="true" --root_submissions="true" --slave_reregister_timeout="10mins" --user_sorter="drf" --version="false" --webui_dir="/usr/local/share/mesos/webui" --work_dir="/tmp/FetcherCacheTest_CachedFallback_dmr8bH/master" --zk_session_timeout="10secs"
> DEBUG: I0608 08:32:39.095630 56598 master.cpp:410] Master only allowing authenticated frameworks to register
> DEBUG: I0608 08:32:39.095636 56598 master.cpp:415] Master only allowing authenticated slaves to register
> DEBUG: I0608 08:32:39.095643 56598 credentials.hpp:37] Loading credentials for authentication from '/tmp/FetcherCacheTest_CachedFallback_dmr8bH/credentials'
> DEBUG: I0608 08:32:39.095743 56598 master.cpp:454] Using default 'crammd5' authenticator
> DEBUG: I0608 08:32:39.095782 56598 master.cpp:491] Authorization enabled
> DEBUG: I0608 08:32:39.096765 56606 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 1.654474ms
> DEBUG: I0608 08:32:39.096788 56606 replica.cpp:323] Persisted replica status to STARTING
> DEBUG: I0608 08:32:39.096925 56612 master.cpp:1474] The newly elected leader is master@<***redacted***> with id 20150608-083239-1787367596-39187-56580
> DEBUG: I0608 08:32:39.096940 56612 master.cpp:1487] Elected as the leading master!
> DEBUG: I0608 08:32:39.096946 56612 master.cpp:1257] Recovering from registrar
> DEBUG: I0608 08:32:39.097033 56608 registrar.cpp:313] Recovering registrar
> DEBUG: I0608 08:32:39.097095 56616 recover.cpp:475] Replica is in STARTING status
> DEBUG: I0608 08:32:39.097718 56607 replica.cpp:641] Replica in STARTING status received a broadcasted recover request
> DEBUG: I0608 08:32:39.097949 56602 recover.cpp:195] Received a recover response from a replica in STARTING status
> DEBUG: I0608 08:32:39.098423 56609 recover.cpp:566] Updating replica status to VOTING
> DEBUG: I0608 08:32:39.099462 56609 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 962629ns
> DEBUG: I0608 08:32:39.099488 56609 replica.cpp:323] Persisted replica status to VOTING
> DEBUG: I0608 08:32:39.099527 56609 recover.cpp:580] Successfully joined the Paxos group
> DEBUG: I0608 08:32:39.099577 56609 recover.cpp:464] Recover process terminated
> DEBUG: I0608 08:32:39.099874 56601 log.cpp:661] Attempting to start the writer
> DEBUG: I0608 08:32:39.101229 56611 replica.cpp:477] Replica received implicit promise request with proposal 1
> DEBUG: I0608 08:32:39.102149 56611 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 894488ns
> DEBUG: I0608 08:32:39.102175 56611 replica.cpp:345] Persisted promised to 1
> DEBUG: I0608 08:32:39.102978 56612 coordinator.cpp:230] Coordinator attemping to fill missing position
> DEBUG: I0608 08:32:39.104015 56612 replica.cpp:378] Replica received explicit promise request for position 0 with proposal 2
> DEBUG: I0608 08:32:39.105124 56612 leveldb.cpp:343] Persisting action (8 bytes) to leveldb took 1.08594ms
> DEBUG: I0608 08:32:39.105156 56612 replica.cpp:679] Persisted action at 0
> DEBUG: I0608 08:32:39.106197 56596 replica.cpp:511] Replica received write request for position 0
> DEBUG: I0608 08:32:39.106230 56596 leveldb.cpp:438] Reading position from leveldb took 16312ns
> DEBUG: I0608 08:32:39.107139 56596 leveldb.cpp:343] Persisting action (14 bytes) to leveldb took 891559ns
> DEBUG: I0608 08:32:39.107167 56596 replica.cpp:679] Persisted action at 0
> DEBUG: I0608 08:32:39.107656 56601 replica.cpp:658] Replica received learned notice for position 0
> DEBUG: I0608 08:32:39.109146 56601 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 1.459405ms
> DEBUG: I0608 08:32:39.109180 56601 replica.cpp:679] Persisted action at 0
> DEBUG: I0608 08:32:39.109194 56601 replica.cpp:664] Replica learned NOP action at position 0
> DEBUG: I0608 08:32:39.109606 56604 log.cpp:677] Writer started with ending position 0
> DEBUG: I0608 08:32:39.109839 56613 leveldb.cpp:438] Reading position from leveldb took 17622ns
> DEBUG: I0608 08:32:39.111635 56600 registrar.cpp:346] Successfully fetched the registry (0B) in 14.553088ms
> DEBUG: I0608 08:32:39.111667 56600 registrar.cpp:445] Applied 1 operations in 2865ns; attempting to update the 'registry'
> DEBUG: I0608 08:32:39.112975 56601 log.cpp:685] Attempting to append 157 bytes to the log
> DEBUG: I0608 08:32:39.113034 56608 coordinator.cpp:340] Coordinator attempting to write APPEND action at position 1
> DEBUG: I0608 08:32:39.113862 56595 replica.cpp:511] Replica received write request for position 1
> DEBUG: I0608 08:32:39.114780 56595 leveldb.cpp:343] Persisting action (176 bytes) to leveldb took 885199ns
> DEBUG: I0608 08:32:39.114806 56595 replica.cpp:679] Persisted action at 1
> DEBUG: I0608 08:32:39.115378 56610 replica.cpp:658] Replica received learned notice for position 1
> DEBUG: I0608 08:32:39.116317 56610 leveldb.cpp:343] Persisting action (178 bytes) to leveldb took 915397ns
> DEBUG: I0608 08:32:39.116343 56610 replica.cpp:679] Persisted action at 1
> DEBUG: I0608 08:32:39.116356 56610 replica.cpp:664] Replica learned APPEND action at position 1
> DEBUG: I0608 08:32:39.117009 56615 registrar.cpp:490] Successfully updated the 'registry' in 4.941824ms
> DEBUG: I0608 08:32:39.117075 56615 registrar.cpp:376] Successfully recovered registrar
> DEBUG: I0608 08:32:39.117147 56615 master.cpp:1284] Recovered 0 slaves from the Registry (119B) ; allowing 10mins for slaves to re-register
> DEBUG: I0608 08:32:39.117447 56614 log.cpp:704] Attempting to truncate the log to 1
> DEBUG: I0608 08:32:39.117504 56613 coordinator.cpp:340] Coordinator attempting to write TRUNCATE action at position 2
> DEBUG: I0608 08:32:39.118638 56608 replica.cpp:511] Replica received write request for position 2
> DEBUG: I0608 08:32:39.119679 56608 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 1.017833ms
> DEBUG: I0608 08:32:39.119707 56608 replica.cpp:679] Persisted action at 2
> DEBUG: I0608 08:32:39.120102 56608 replica.cpp:658] Replica received learned notice for position 2
> DEBUG: I0608 08:32:39.121323 56608 leveldb.cpp:343] Persisting action (18 bytes) to leveldb took 1.201996ms
> DEBUG: I0608 08:32:39.121378 56608 leveldb.cpp:401] Deleting ~1 keys from leveldb took 22912ns
> DEBUG: I0608 08:32:39.121395 56608 replica.cpp:679] Persisted action at 2
> DEBUG: I0608 08:32:39.121404 56608 replica.cpp:664] Replica learned TRUNCATE action at position 2
> DEBUG: I0608 08:32:39.129438 56580 containerizer.cpp:111] Using isolation: posix/cpu,posix/mem
> DEBUG: I0608 08:32:39.132251 56615 slave.cpp:188] Slave started on 40)@<***redacted***>
> DEBUG: I0608 08:32:39.132272 56615 slave.cpp:189] Flags at startup: --authenticatee="crammd5" --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/FetcherCacheTest_CachedFallback_P03rUd/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_remove_delay="6hrs" --docker_sandbox_directory="/mnt/mesos/sandbox" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --egress_unique_flow_per_container="false" --enforce_container_disk_quota="false" --ephemeral_ports_per_container="1024" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/FetcherCacheTest_CachedFallback_P03rUd/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher_dir="/builddir/build/BUILD/mesos-0.23.0/src" --logbufsecs="0" --logging_level="INFO" --network_enable_socket_statistics_details="false" --network_enable_socket_statistics_summary="false" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resource_monitoring_interval="1secs" --resources="cpus(*):1000; mem(*):1000" --revocable_cpu_low_priority="true" --strict="true" --switch_user="true" --version="false" --work_dir="/tmp/FetcherCacheTest_CachedFallback_P03rUd"
> DEBUG: I0608 08:32:39.132558 56615 credentials.hpp:85] Loading credential for authentication from '/tmp/FetcherCacheTest_CachedFallback_P03rUd/credential'
> DEBUG: I0608 08:32:39.132689 56615 slave.cpp:319] Slave using credential for: test-principal
> DEBUG: I0608 08:32:39.132869 56615 slave.cpp:352] Slave resources: cpus(*):1000; mem(*):1000; disk(*):464332; ports(*):[31000-32000]
> DEBUG: I0608 08:32:39.133673 56615 slave.cpp:382] Slave hostname: <***redacted***>
> DEBUG: I0608 08:32:39.133689 56615 slave.cpp:387] Slave checkpoint: true
> DEBUG: I0608 08:32:39.133949 56596 state.cpp:35] Recovering state from '/tmp/FetcherCacheTest_CachedFallback_P03rUd/meta'
> DEBUG: I0608 08:32:39.134446 56595 status_update_manager.cpp:201] Recovering status update manager
> DEBUG: I0608 08:32:39.134539 56609 containerizer.cpp:312] Recovering containerizer
> DEBUG: I0608 08:32:39.135972 56616 slave.cpp:3950] Finished recovery
> DEBUG: I0608 08:32:39.136243 56616 slave.cpp:4104] Querying resource estimator for oversubscribable resources
> DEBUG: I0608 08:32:39.136576 56599 status_update_manager.cpp:175] Pausing sending status updates
> DEBUG: I0608 08:32:39.136595 56602 slave.cpp:678] New master detected at master@<***redacted***>
> DEBUG: I0608 08:32:39.136620 56602 slave.cpp:741] Authenticating with master master@<***redacted***>
> DEBUG: I0608 08:32:39.136628 56602 slave.cpp:746] Using default CRAM-MD5 authenticatee
> DEBUG: I0608 08:32:39.136670 56602 slave.cpp:714] Detecting new master
> DEBUG: I0608 08:32:39.136698 56602 slave.cpp:4125] Received oversubscribable resources  from the resource estimator
> DEBUG: I0608 08:32:39.136703 56602 slave.cpp:4129] No master detected. Re-querying resource estimator after 15secs
> DEBUG: I0608 08:32:39.136778 56618 authenticatee.hpp:139] Creating new client SASL connection
> DEBUG: I0608 08:32:39.137074 56618 master.cpp:4167] Authenticating slave(40)@<***redacted***>
> DEBUG: I0608 08:32:39.137186 56611 authenticator.cpp:92] Creating new server SASL connection
> DEBUG: I0608 08:32:39.137485 56605 authenticatee.hpp:230] Received SASL authentication mechanisms: CRAM-MD5
> DEBUG: I0608 08:32:39.137503 56605 authenticatee.hpp:256] Attempting to authenticate with mechanism 'CRAM-MD5'
> DEBUG: I0608 08:32:39.137540 56605 authenticator.cpp:197] Received SASL authentication start
> DEBUG: I0608 08:32:39.137615 56605 authenticator.cpp:319] Authentication requires more steps
> DEBUG: I0608 08:32:39.137645 56605 authenticatee.hpp:276] Received SASL authentication step
> DEBUG: I0608 08:32:39.137817 56609 authenticator.cpp:225] Received SASL authentication step
> DEBUG: I0608 08:32:39.137866 56609 authenticator.cpp:311] Authentication success
> DEBUG: I0608 08:32:39.137989 56609 master.cpp:4197] Successfully authenticated principal 'test-principal' at slave(40)@<***redacted***>
> DEBUG: I0608 08:32:39.138123 56601 authenticatee.hpp:316] Authentication success
> DEBUG: I0608 08:32:39.138363 56601 slave.cpp:812] Successfully authenticated with master master@<***redacted***>
> DEBUG: I0608 08:32:39.138468 56596 master.cpp:3149] Registering slave at slave(40)@<***redacted***> (<***redacted***>) with id 20150608-083239-1787367596-39187-56580-S0
> DEBUG: I0608 08:32:39.138628 56614 registrar.cpp:445] Applied 1 operations in 11844ns; attempting to update the 'registry'
> DEBUG: I0608 08:32:39.140049 56596 log.cpp:685] Attempting to append 351 bytes to the log
> DEBUG: I0608 08:32:39.140110 56600 coordinator.cpp:340] Coordinator attempting to write APPEND action at position 3
> DEBUG: I0608 08:32:39.141154 56596 replica.cpp:511] Replica received write request for position 3
> DEBUG: I0608 08:32:39.142328 56596 leveldb.cpp:343] Persisting action (370 bytes) to leveldb took 1.151559ms
> DEBUG: I0608 08:32:39.142359 56596 replica.cpp:679] Persisted action at 3
> DEBUG: I0608 08:32:39.142838 56607 replica.cpp:658] Replica received learned notice for position 3
> DEBUG: I0608 08:32:39.144026 56607 leveldb.cpp:343] Persisting action (372 bytes) to leveldb took 1.167494ms
> DEBUG: I0608 08:32:39.144060 56607 replica.cpp:679] Persisted action at 3
> DEBUG: I0608 08:32:39.144073 56607 replica.cpp:664] Replica learned APPEND action at position 3
> DEBUG: I0608 08:32:39.144342 56595 registrar.cpp:490] Successfully updated the 'registry' in 5696us
> DEBUG: I0608 08:32:39.144366 56607 log.cpp:704] Attempting to truncate the log to 3
> DEBUG: I0608 08:32:39.144423 56614 coordinator.cpp:340] Coordinator attempting to write TRUNCATE action at position 4
> DEBUG: I0608 08:32:39.144631 56607 master.cpp:3206] Registered slave 20150608-083239-1787367596-39187-56580-S0 at slave(40)@<***redacted***> (<***redacted***>) with cpus(*):1000; mem(*):1000; disk(*):464332; ports(*):[31000-32000]
> DEBUG: I0608 08:32:39.144726 56617 hierarchical.hpp:496] Added slave 20150608-083239-1787367596-39187-56580-S0 (<***redacted***>) with cpus(*):1000; mem(*):1000; disk(*):464332; ports(*):[31000-32000] (and cpus(*):1000; mem(*):1000; disk(*):464332; ports(*):[31000-32000] available)
> DEBUG: I0608 08:32:39.144745 56609 slave.cpp:846] Registered with master master@<***redacted***>; given slave ID 20150608-083239-1787367596-39187-56580-S0
> DEBUG: I0608 08:32:39.144872 56612 status_update_manager.cpp:182] Resuming sending status updates
> DEBUG: I0608 08:32:39.145023 56602 replica.cpp:511] Replica received write request for position 4
> DEBUG: GMOCK WARNING:
> DEBUG: Uninteresting mock function call - returning directly.
> DEBUG:     Function call: resourceOffers(0x3754860, @0x7fad6e321b30 { 128-byte object <50-DB E0-80 AD-7F 00-00 00-00 00-00 00-00 00-00 D0-78 00-04 AD-7F 00-00 70-79 00-04 AD-7F 00-00 10-7A 00-04 AD-7F 00-00 B0-7A 00-04 AD-7F 00-00 A0-6B 00-04 AD-7F 00-00 04-00 00-00 04-00 00-00 04-00 00-00 00-00 00-00 00-00 00-00 00-00 00-00 00-00 00-00 00-00 00-00 00-00 00-00 00-00 00-00 00-00 00-00 00-00 00-00 00-00 00-00 00-00 00-00 00-00 00-00 00-00 00-00 00-00 00-00 0F-00 00-00> })
> DEBUG: Stack trace:
> DEBUG: I0608 08:32:39.146750 56580 sched.cpp:157] Version: 0.23.0-rc0
> DEBUG: I0608 08:32:39.147104 56613 sched.cpp:254] New master detected at master@<***redacted***>
> DEBUG: I0608 08:32:39.147121 56613 sched.cpp:310] Authenticating with master master@<***redacted***>
> DEBUG: I0608 08:32:39.147128 56613 sched.cpp:317] Using default CRAM-MD5 authenticatee
> DEBUG: I0608 08:32:39.147186 56613 authenticatee.hpp:139] Creating new client SASL connection
> DEBUG: I0608 08:32:39.147374 56595 master.cpp:4167] Authenticating scheduler-4b62df2f-7cdc-427c-8301-0e282d99bc06@<***redacted***>
> DEBUG: I0608 08:32:39.147596 56595 authenticator.cpp:92] Creating new server SASL connection
> DEBUG: I0608 08:32:39.147666 56595 authenticatee.hpp:230] Received SASL authentication mechanisms: CRAM-MD5
> DEBUG: I0608 08:32:39.147678 56595 authenticatee.hpp:256] Attempting to authenticate with mechanism 'CRAM-MD5'
> DEBUG: I0608 08:32:39.147701 56595 authenticator.cpp:197] Received SASL authentication start
> DEBUG: I0608 08:32:39.147738 56595 authenticator.cpp:319] Authentication requires more steps
> DEBUG: I0608 08:32:39.147789 56615 authenticatee.hpp:276] Received SASL authentication step
> DEBUG: I0608 08:32:39.147853 56615 authenticator.cpp:225] Received SASL authentication step
> DEBUG: I0608 08:32:39.147881 56615 authenticator.cpp:311] Authentication success
> DEBUG: I0608 08:32:39.147923 56615 authenticatee.hpp:316] Authentication success
> DEBUG: I0608 08:32:39.148066 56617 master.cpp:4197] Successfully authenticated principal 'test-principal' at scheduler-4b62df2f-7cdc-427c-8301-0e282d99bc06@<***redacted***>
> DEBUG: I0608 08:32:39.148905 56598 sched.cpp:398] Successfully authenticated with master master@<***redacted***>
> DEBUG: I0608 08:32:39.149000 56608 master.cpp:1714] Received registration request for framework 'default' at scheduler-4b62df2f-7cdc-427c-8301-0e282d99bc06@<***redacted***>
> DEBUG: W0608 08:32:39.149026 56608 master.cpp:1537] Framework at scheduler-4b62df2f-7cdc-427c-8301-0e282d99bc06@<***redacted***> (authenticated as 'test-principal') does not specify principal in its FrameworkInfo
> DEBUG: I0608 08:32:39.149039 56608 master.cpp:1553] Authorizing framework principal '' to receive offers for role '*'
> DEBUG: I0608 08:32:39.149502 56618 master.cpp:1781] Registering framework 20150608-083239-1787367596-39187-56580-0000 (default) at scheduler-4b62df2f-7cdc-427c-8301-0e282d99bc06@<***redacted***>
> DEBUG: I0608 08:32:39.149587 56618 hierarchical.hpp:354] Added framework 20150608-083239-1787367596-39187-56580-0000
> DEBUG: I0608 08:32:39.149668 56614 sched.cpp:448] Framework registered with 20150608-083239-1787367596-39187-56580-0000
> DEBUG: I0608 08:32:39.149765 56615 master.cpp:4086] Sending 1 offers to framework 20150608-083239-1787367596-39187-56580-0000 (default) at scheduler-4b62df2f-7cdc-427c-8301-0e282d99bc06@<***redacted***>
> DEBUG: I0608 08:32:39.153530 56602 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 8.487561ms
> DEBUG: I0608 08:32:39.153561 56602 replica.cpp:679] Persisted action at 4
> DEBUG: I0608 08:32:39.154438 56603 replica.cpp:658] Replica received learned notice for position 4
> DEBUG: I0608 08:32:39.155531 56603 leveldb.cpp:343] Persisting action (18 bytes) to leveldb took 1.074345ms
> DEBUG: I0608 08:32:39.155571 56603 leveldb.cpp:401] Deleting ~2 keys from leveldb took 16036ns
> DEBUG: I0608 08:32:39.155580 56603 replica.cpp:679] Persisted action at 4
> DEBUG: I0608 08:32:39.155587 56603 replica.cpp:664] Replica learned TRUNCATE action at position 4
> DEBUG: I0608 08:32:54.136912 56596 slave.cpp:4104] Querying resource estimator for oversubscribable resources
> DEBUG: I0608 08:32:54.137251 56611 slave.cpp:4125] Received oversubscribable resources  from the resource estimator
> DEBUG: F0608 08:32:54.154590 56580 fetcher_cache_tests.cpp:354] CHECK_READY(offers): is PENDING Failed to wait for resource offers
> DEBUG: *** Check failure stack trace: ***
> DEBUG:     @     0x7fad806b9f1d  google::LogMessage::Fail()
> DEBUG:     @     0x7fad806bbd5d  google::LogMessage::SendToLog()
> DEBUG:     @     0x7fad806b9b0c  google::LogMessage::Flush()
> DEBUG:     @     0x7fad806bc659  google::LogMessageFatal::~LogMessageFatal()
> DEBUG:     @           0x53d858  _CheckFatal::~_CheckFatal()
> DEBUG:     @           0x66c14f  mesos::internal::tests::FetcherCacheTest::launchTask()
> DEBUG:     @           0x66f9e9  mesos::internal::tests::FetcherCacheTest_CachedFallback_Test::TestBody()
> DEBUG:     @           0xba34d3  testing::internal::HandleExceptionsInMethodIfSupported<>()
> DEBUG:     @           0xb9a777  testing::Test::Run()
> DEBUG:     @           0xb9a81e  testing::TestInfo::Run()
> DEBUG:     @           0xb9a925  testing::TestCase::Run()
> DEBUG:     @           0xb9abc8  testing::internal::UnitTestImpl::RunAllTests()
> DEBUG:     @           0xb9ae67  testing::UnitTest::Run()
> DEBUG:     @           0x4a1e73  main
> DEBUG:     @     0x7fad7e4e2d5d  __libc_start_main
> DEBUG:     @           0x4acf79  (unknown)
> DEBUG: make[3]: *** [check-local] Aborted (core dumped)
> {code}



--
This message was sent by Atlassian JIRA
(v6.3.4#6332)