Uploaded image for project: 'PHP Driver: Extension'
  1. PHP Driver: Extension
  2. PHPC-1878

Unexpected primary step down when testing on MongoDB latest

    • Type: Icon: Task Task
    • Resolution: Fixed
    • Priority: Icon: Minor - P4 Minor - P4
    • 1.12.0
    • Affects Version/s: None
    • Component/s: Tests
    • Labels:
      None

      The following build variant are failing:

      • MongoDB latest/PHP 7.3 — RHEL 7.0
      • MongoDB latest/PHP 7.3 — Ubuntu 18.04 ARM64

      In both cases, the server version appears to be older than the actual "latest": v5.0.0-alpha0-1315-gde878d5

      Two tests fail due to an unexpected "Primary stepped down while waiting for replication" error attempting to execute a write:

      • tests/replicaset/writeresult-getserver-002.phpt
      • tests/server/server-executeBulkWrite-005.phpt

      See task log:

      [2021/06/28 18:55:09.810] ========DIFF========
       [2021/06/28 18:55:09.810] 005+
       [2021/06/28 18:55:09.810] 006+ Fatal error: Uncaught MongoDB\Driver\Exception\BulkWriteException: Primary stepped down while waiting for replication in /data/mci/471f405e53ff5b59232b23bc13d01644/src/tests/replicaset/writeresult-getserver-002.php:36
       [2021/06/28 18:55:09.810] 007+ Stack trace:
       [2021/06/28 18:55:09.810] 008+ #0 /data/mci/471f405e53ff5b59232b23bc13d01644/src/tests/replicaset/writeresult-getserver-002.php(36): MongoDB\Driver\Server->executeBulkWrite('local.replicase...', Object(MongoDB\Driver\BulkWrite))
       [2021/06/28 18:55:09.810] 009+ #1 {main}
       [2021/06/28 18:55:09.810] 010+   thrown in /data/mci/471f405e53ff5b59232b23bc13d01644/src/tests/replicaset/writeresult-getserver-002.php on line 36
       [2021/06/28 18:55:09.810] 005- object(MongoDB\Driver\WriteResult)#%d (%d) {
       [2021/06/28 18:55:09.810] 006-   ["nInserted"]=>
       [2021/06/28 18:55:09.810] 007-   int(1)
       [2021/06/28 18:55:09.810] 008-   ["nMatched"]=>
       [2021/06/28 18:55:09.810] 009-   int(0)
       [2021/06/28 18:55:09.810] 010-   ["nModified"]=>
       [2021/06/28 18:55:09.810] 011-   int(0)
       [2021/06/28 18:55:09.810] 012-   ["nRemoved"]=>
       [2021/06/28 18:55:09.810] 013-   int(0)
       [2021/06/28 18:55:09.810] 014-   ["nUpserted"]=>
       [2021/06/28 18:55:09.810] 015-   int(0)
       [2021/06/28 18:55:09.810] 016-   ["upsertedIds"]=>
       [2021/06/28 18:55:09.810] 017-   array(0) {
       [2021/06/28 18:55:09.810] 018-   }
       [2021/06/28 18:55:09.810] 019-   ["writeErrors"]=>
       [2021/06/28 18:55:09.810] 020-   array(0) {
       [2021/06/28 18:55:09.810] 021-   }
       [2021/06/28 18:55:09.810] 022-   ["writeConcernError"]=>
       [2021/06/28 18:55:09.810] 023-   NULL
       [2021/06/28 18:55:09.810] 024-   ["writeConcern"]=>
       [2021/06/28 18:55:09.810] 025-   object(MongoDB\Driver\WriteConcern)#%d (%d) {
       [2021/06/28 18:55:09.810] 026-   }
       [2021/06/28 18:55:09.810] 027- }
       [2021/06/28 18:55:09.810] 028- string(%d) "%s"
       [2021/06/28 18:55:09.810] 029- int(%d)
       [2021/06/28 18:55:09.810] 030- object(stdClass)#%d (2) {
       [2021/06/28 18:55:09.810] 031-   ["_id"]=>
       [2021/06/28 18:55:09.810] 032-   object(%s\ObjectId)#%d (1) {
       [2021/06/28 18:55:09.810] 033-     ["oid"]=>
       [2021/06/28 18:55:09.810] 034-     string(24) "%s"
       [2021/06/28 18:55:09.810] 035-   }
       [2021/06/28 18:55:09.810] 036-   ["example"]=>
       [2021/06/28 18:55:09.810] 037-   string(8) "document"
       [2021/06/28 18:55:09.810] 038- }
       [2021/06/28 18:55:09.810] 039- ===DONE===
       [2021/06/28 18:55:09.810] ========DONE========
       [2021/06/28 18:55:09.810] FAIL MongoDB\Driver\Server: Manager->getServer() returning correct server [tests/replicaset/writeresult-getserver-002.phpt]
       [2021/06/28 18:55:11.310] SKIP Retryable writes: actionable error message when using retryable writes on unsupported storage engines [tests/retryable-writes/retryable-writes_error-001.phpt] reason: Server storage engine is 'wiredTiger' (needed 'mmapv1')
       [2021/06/28 18:55:11.742] ========DIFF========
       [2021/06/28 18:55:11.742] 005+
       [2021/06/28 18:55:11.742] 005- ===DONE===
       [2021/06/28 18:55:11.742] 006+ Fatal error: Uncaught MongoDB\Driver\Exception\BulkWriteException: Primary stepped down while waiting for replication in /data/mci/471f405e53ff5b59232b23bc13d01644/src/tests/server/server-executeBulkWrite-005.php:23
       [2021/06/28 18:55:11.742] 007+ Stack trace:
       [2021/06/28 18:55:11.742] 008+ #0 /data/mci/471f405e53ff5b59232b23bc13d01644/src/tests/server/server-executeBulkWrite-005.php(23): MongoDB\Driver\Server->executeBulkWrite('local.server_se...', Object(MongoDB\Driver\BulkWrite))
       [2021/06/28 18:55:11.742] 009+ #1 {main}
       [2021/06/28 18:55:11.742] 010+   thrown in /data/mci/471f405e53ff5b59232b23bc13d01644/src/tests/server/server-executeBulkWrite-005.php on line 23
       [2021/06/28 18:55:11.742] ========DONE========
       [2021/06/28 18:55:11.742] FAIL MongoDB\Driver\Server::executeBulkWrite() with write concern (replica set secondary, local DB) [tests/server/server-executeBulkWrite-005.phpt]
      

      Related patch build: https://spruce.mongodb.com/version/60d9e497a4cf47781b41b84d/tasks

            Assignee:
            jmikola@mongodb.com Jeremy Mikola
            Reporter:
            jmikola@mongodb.com Jeremy Mikola
            Votes:
            0 Vote for this issue
            Watchers:
            1 Start watching this issue

              Created:
              Updated:
              Resolved: