Class com.ibm.ws.security.jwt.internal.ConsumerUtilTest

72

tests

0

failures

0

ignored

0.399s

duration

100%

successful

Tests

Test Duration Result
testGetAlgorithmHeader_missingJsonWebStructures 0.026s passed
testGetAlgorithmHeader_nullContext 0.001s passed
testGetAlgorithmHeader_validAlgorithmHeader 0.005s passed
testGetPublicKey_missingKeyStoreService 0.002s passed
testGetPublicKey_notRSAPublicKey 0.002s passed
testGetPublicKey_nullArgs 0.031s passed
testGetPublicKey_throwsException 0.004s passed
testGetPublicKey_validKey 0.004s passed
testGetSharedSecretKey_emptyOrNullKey 0.003s passed
testGetSharedSecretKey_nullConfig 0.002s passed
testGetSharedSecretKey_validKey 0.004s passed
testGetSigningKey_HS256ThrowsException 0.006s passed
testGetSigningKey_HS256Valid 0.002s passed
testGetSigningKey_RS256ThrowsException 0.004s passed
testGetSigningKey_RS256Valid 0.043s passed
testGetSigningKey_nullConfig 0.001s passed
testGetSigningKey_unknownAlg 0.024s passed
testParseJwtWithoutValidation_nullOrEmptyTokenString 0.002s passed
testParseJwtWithoutValidation_singlePartTokenString 0.006s passed
testParseJwtWithoutValidation_threePartMalformedTokenString 0.011s passed
testParseJwtWithoutValidation_twoPartTokenString 0.002s passed
testValidateAlgorithm_algMatch 0.003s passed
testValidateAlgorithm_algMismatch 0.019s passed
testValidateAlgorithm_nullArgs 0.002s passed
testValidateAudience 0.001s passed
testValidateClaimsReadsConfigProperty 0.013s passed
testValidateIatAndExp_expFuture_outsideClockSkew_iatFuture_outsideClockSkew 0.005s passed
testValidateIatAndExp_expFuture_withinClockSkew_iatFuture_outsideClockSkew 0.006s passed
testValidateIatAndExp_expFuture_withinClockSkew_iatFuture_withinClockSkew 0.007s passed
testValidateIatAndExp_expPast_iatFuture_outsideClockSkew 0.005s passed
testValidateIatAndExp_expPast_iatFuture_withinClockSkew 0.007s passed
testValidateIatAndExp_expPast_outsideClockSkew_iatPast_outsideClockSkew 0.006s passed
testValidateIatAndExp_expPast_outsideClockSkew_iatPast_withinClockSkew 0.007s passed
testValidateIatAndExp_expPast_withinClockSkew_iatPast_withinClockSkew 0.007s passed
testValidateIatAndExp_iatFuture_outsideClockSkew_expFuture_outsideClockSkew 0.005s passed
testValidateIatAndExp_iatFuture_withinClockSkew_expFuture_outsideClockSkew 0.002s passed
testValidateIatAndExp_iatFuture_withinClockSkew_expFuture_withinClockSkew 0.003s passed
testValidateIatAndExp_iatPast_expFuture 0.003s passed
testValidateIatAndExp_iatPast_outsideClockSkew_expPast_outsideClockSkew 0.005s passed
testValidateIatAndExp_iatPast_outsideClockSkew_expPast_withinClockSkew 0.002s passed
testValidateIatAndExp_iatPast_withinClockSkew_expPast_withinClockSkew 0.003s passed
testValidateIatAndExp_malformedExp 0.002s passed
testValidateIatAndExp_malformedIat 0.033s passed
testValidateIatAndExp_nullClaims 0.002s passed
testValidateIatAndExp_nullExp 0.003s passed
testValidateIatAndExp_nullIat 0.007s passed
testValidateIssuer_commaTrustedIssuers 0.002s passed
testValidateIssuer_multipleTrustedIssuers 0.001s passed
testValidateIssuer_multipleTrustedIssuers_emptyTokenIssuer 0.001s passed
testValidateIssuer_multipleTrustedIssuers_nullTokenIssuer 0.001s passed
testValidateIssuer_multipleTrustedIssuers_tokenIssuerContainsTrustedIssuer 0.003s passed
testValidateIssuer_multipleTrustedIssuers_tokenIssuerWithComma 0.002s passed
testValidateIssuer_multipleTrustedIssuers_untrustedTokenIssuer 0.002s passed
testValidateIssuer_nullOrEmptyArgs 0.003s passed
testValidateIssuer_singleTrustedIssuer 0.001s passed
testValidateIssuer_singleTrustedIssuer_emptyTokenIssuer 0.002s passed
testValidateIssuer_singleTrustedIssuer_emptyTokenIssuer_leadingAndTrailingCommaTrusted 0.002s passed
testValidateIssuer_singleTrustedIssuer_emptyTokenIssuer_trailingCommaTrusted 0.002s passed
testValidateIssuer_singleTrustedIssuer_nullTokenIssuer 0.002s passed
testValidateIssuer_singleTrustedIssuer_tokenIssuerSubstringOfTrusted 0.005s passed
testValidateIssuer_singleTrustedIssuer_tokenIssuerSuperStringWithComma 0.006s passed
testValidateIssuer_singleTrustedIssuer_tokenIssuerSuperStringWithSpace 0.002s passed
testValidateIssuer_singleTrustedIssuer_untrustedTokenIssuer 0.002s passed
testValidateIssuer_trustAllIssuers 0.003s passed
testValidateIssuer_whitespaceTrustedIssuers 0.001s passed
testValidateNbf_futureNbf_outsideClockSkew 0.005s passed
testValidateNbf_futureNbf_withinClockSkew 0.001s passed
testValidateNbf_nbfThrowsException 0.002s passed
testValidateNbf_nullClaims 0.001s passed
testValidateNbf_nullNbf 0.002s passed
testValidateNbf_pastNbf_outsideClockSkew 0.001s passed
testValidateNbf_pastNbf_withinClockSkew 0.001s passed

Standard output

SharedOutputManager captured the following: 
-- System.out -------------------------------------------------
Entering test: testValidateClaimsReadsConfigProperty
Exiting test: testValidateClaimsReadsConfigProperty
Entering test: testGetSigningKey_nullConfig
Exiting test: testGetSigningKey_nullConfig
Entering test: testGetSigningKey_unknownAlg
Exiting test: testGetSigningKey_unknownAlg
Entering test: testGetSigningKey_HS256ThrowsException
Exiting test: testGetSigningKey_HS256ThrowsException
Entering test: testGetSigningKey_HS256Valid
Exiting test: testGetSigningKey_HS256Valid
Entering test: testGetSigningKey_RS256ThrowsException
Exiting test: testGetSigningKey_RS256ThrowsException
Entering test: testGetSigningKey_RS256Valid
Exiting test: testGetSigningKey_RS256Valid
Entering test: testGetSharedSecretKey_nullConfig
Exiting test: testGetSharedSecretKey_nullConfig
Entering test: testGetSharedSecretKey_emptyOrNullKey
Chose key: []
Exiting test: testGetSharedSecretKey_emptyOrNullKey
Entering test: testGetSharedSecretKey_validKey
Exiting test: testGetSharedSecretKey_validKey
Entering test: testGetPublicKey_missingKeyStoreService
Exiting test: testGetPublicKey_missingKeyStoreService
Entering test: testGetPublicKey_nullArgs
Exiting test: testGetPublicKey_nullArgs
Entering test: testGetPublicKey_throwsException
Exiting test: testGetPublicKey_throwsException
Entering test: testGetPublicKey_notRSAPublicKey
Exiting test: testGetPublicKey_notRSAPublicKey
Entering test: testGetPublicKey_validKey
Exiting test: testGetPublicKey_validKey
Entering test: testParseJwtWithoutValidation_nullOrEmptyTokenString
Exiting test: testParseJwtWithoutValidation_nullOrEmptyTokenString
Entering test: testParseJwtWithoutValidation_singlePartTokenString
Exiting test: testParseJwtWithoutValidation_singlePartTokenString
Entering test: testParseJwtWithoutValidation_twoPartTokenString
Exiting test: testParseJwtWithoutValidation_twoPartTokenString
Entering test: testParseJwtWithoutValidation_threePartMalformedTokenString
Exiting test: testParseJwtWithoutValidation_threePartMalformedTokenString
Entering test: testValidateIssuer_nullOrEmptyArgs
Exiting test: testValidateIssuer_nullOrEmptyArgs
Entering test: testValidateIssuer_whitespaceTrustedIssuers
Exiting test: testValidateIssuer_whitespaceTrustedIssuers
Entering test: testValidateIssuer_commaTrustedIssuers
Exiting test: testValidateIssuer_commaTrustedIssuers
Entering test: testValidateIssuer_singleTrustedIssuer_nullTokenIssuer
Exiting test: testValidateIssuer_singleTrustedIssuer_nullTokenIssuer
Entering test: testValidateIssuer_singleTrustedIssuer_emptyTokenIssuer
Exiting test: testValidateIssuer_singleTrustedIssuer_emptyTokenIssuer
Entering test: testValidateIssuer_singleTrustedIssuer_untrustedTokenIssuer
Exiting test: testValidateIssuer_singleTrustedIssuer_untrustedTokenIssuer
Entering test: testValidateIssuer_singleTrustedIssuer_tokenIssuerSubstringOfTrusted
Exiting test: testValidateIssuer_singleTrustedIssuer_tokenIssuerSubstringOfTrusted
Entering test: testValidateIssuer_singleTrustedIssuer_tokenIssuerSuperStringWithComma
Exiting test: testValidateIssuer_singleTrustedIssuer_tokenIssuerSuperStringWithComma
Entering test: testValidateIssuer_singleTrustedIssuer_tokenIssuerSuperStringWithSpace
Exiting test: testValidateIssuer_singleTrustedIssuer_tokenIssuerSuperStringWithSpace
Entering test: testValidateIssuer_singleTrustedIssuer_emptyTokenIssuer_trailingCommaTrusted
Exiting test: testValidateIssuer_singleTrustedIssuer_emptyTokenIssuer_trailingCommaTrusted
Entering test: testValidateIssuer_singleTrustedIssuer_emptyTokenIssuer_leadingAndTrailingCommaTrusted
Exiting test: testValidateIssuer_singleTrustedIssuer_emptyTokenIssuer_leadingAndTrailingCommaTrusted
Entering test: testValidateIssuer_singleTrustedIssuer
Exiting test: testValidateIssuer_singleTrustedIssuer
Entering test: testValidateIssuer_multipleTrustedIssuers_nullTokenIssuer
Exiting test: testValidateIssuer_multipleTrustedIssuers_nullTokenIssuer
Entering test: testValidateIssuer_multipleTrustedIssuers_emptyTokenIssuer
Exiting test: testValidateIssuer_multipleTrustedIssuers_emptyTokenIssuer
Entering test: testValidateIssuer_multipleTrustedIssuers_untrustedTokenIssuer
Exiting test: testValidateIssuer_multipleTrustedIssuers_untrustedTokenIssuer
Entering test: testValidateIssuer_multipleTrustedIssuers_tokenIssuerContainsTrustedIssuer
Exiting test: testValidateIssuer_multipleTrustedIssuers_tokenIssuerContainsTrustedIssuer
Entering test: testValidateIssuer_multipleTrustedIssuers_tokenIssuerWithComma
Exiting test: testValidateIssuer_multipleTrustedIssuers_tokenIssuerWithComma
Entering test: testValidateIssuer_multipleTrustedIssuers
Exiting test: testValidateIssuer_multipleTrustedIssuers
Entering test: testValidateIssuer_trustAllIssuers
Exiting test: testValidateIssuer_trustAllIssuers
Entering test: testValidateAudience
Exiting test: testValidateAudience
Entering test: testValidateIatAndExp_nullClaims
Exiting test: testValidateIatAndExp_nullClaims
Entering test: testValidateIatAndExp_malformedIat
Exiting test: testValidateIatAndExp_malformedIat
Entering test: testValidateIatAndExp_malformedExp
Exiting test: testValidateIatAndExp_malformedExp
Entering test: testValidateIatAndExp_nullIat
Exiting test: testValidateIatAndExp_nullIat
Entering test: testValidateIatAndExp_nullExp
Exiting test: testValidateIatAndExp_nullExp
Entering test: testValidateIatAndExp_iatPast_outsideClockSkew_expPast_outsideClockSkew
Original string: [2018-09-06T01:00:48+0100]
Regex string   : [\Q2018-09-06T01:00:48+0100\E]
Exiting test: testValidateIatAndExp_iatPast_outsideClockSkew_expPast_outsideClockSkew
Entering test: testValidateIatAndExp_expPast_outsideClockSkew_iatPast_outsideClockSkew
Original string: [2018-09-06T01:00:48+0100]
Regex string   : [\Q2018-09-06T01:00:48+0100\E]
Original string: [2018-09-06T00:59:48+0100]
Regex string   : [\Q2018-09-06T00:59:48+0100\E]
Exiting test: testValidateIatAndExp_expPast_outsideClockSkew_iatPast_outsideClockSkew
Entering test: testValidateIatAndExp_iatPast_outsideClockSkew_expPast_withinClockSkew
Exiting test: testValidateIatAndExp_iatPast_outsideClockSkew_expPast_withinClockSkew
Entering test: testValidateIatAndExp_expPast_outsideClockSkew_iatPast_withinClockSkew
Original string: [2018-09-06T01:58:48+0100]
Regex string   : [\Q2018-09-06T01:58:48+0100\E]
Original string: [2018-09-06T00:59:48+0100]
Regex string   : [\Q2018-09-06T00:59:48+0100\E]
Exiting test: testValidateIatAndExp_expPast_outsideClockSkew_iatPast_withinClockSkew
Entering test: testValidateIatAndExp_iatPast_withinClockSkew_expPast_withinClockSkew
Exiting test: testValidateIatAndExp_iatPast_withinClockSkew_expPast_withinClockSkew
Entering test: testValidateIatAndExp_expPast_withinClockSkew_iatPast_withinClockSkew
Original string: [2018-09-06T01:58:48+0100]
Regex string   : [\Q2018-09-06T01:58:48+0100\E]
Original string: [2018-09-06T01:57:48+0100]
Regex string   : [\Q2018-09-06T01:57:48+0100\E]
Exiting test: testValidateIatAndExp_expPast_withinClockSkew_iatPast_withinClockSkew
Entering test: testValidateIatAndExp_iatPast_expFuture
Exiting test: testValidateIatAndExp_iatPast_expFuture
Entering test: testValidateIatAndExp_expPast_iatFuture_outsideClockSkew
Original string: [2018-09-06T02:59:48+0100]
Regex string   : [\Q2018-09-06T02:59:48+0100\E]
Exiting test: testValidateIatAndExp_expPast_iatFuture_outsideClockSkew
Entering test: testValidateIatAndExp_expPast_iatFuture_withinClockSkew
Original string: [2018-09-06T02:00:48+0100]
Regex string   : [\Q2018-09-06T02:00:48+0100\E]
Original string: [2018-09-06T01:58:48+0100]
Regex string   : [\Q2018-09-06T01:58:48+0100\E]
Exiting test: testValidateIatAndExp_expPast_iatFuture_withinClockSkew
Entering test: testValidateIatAndExp_iatFuture_outsideClockSkew_expFuture_outsideClockSkew
Original string: [2018-09-06T02:59:48+0100]
Regex string   : [\Q2018-09-06T02:59:48+0100\E]
Exiting test: testValidateIatAndExp_iatFuture_outsideClockSkew_expFuture_outsideClockSkew
Entering test: testValidateIatAndExp_expFuture_outsideClockSkew_iatFuture_outsideClockSkew
Original string: [2018-09-06T03:00:48+0100]
Regex string   : [\Q2018-09-06T03:00:48+0100\E]
Exiting test: testValidateIatAndExp_expFuture_outsideClockSkew_iatFuture_outsideClockSkew
Entering test: testValidateIatAndExp_expFuture_withinClockSkew_iatFuture_outsideClockSkew
Original string: [2018-09-06T02:59:48+0100]
Regex string   : [\Q2018-09-06T02:59:48+0100\E]
Exiting test: testValidateIatAndExp_expFuture_withinClockSkew_iatFuture_outsideClockSkew
Entering test: testValidateIatAndExp_iatFuture_withinClockSkew_expFuture_outsideClockSkew
Exiting test: testValidateIatAndExp_iatFuture_withinClockSkew_expFuture_outsideClockSkew
Entering test: testValidateIatAndExp_iatFuture_withinClockSkew_expFuture_withinClockSkew
Exiting test: testValidateIatAndExp_iatFuture_withinClockSkew_expFuture_withinClockSkew
Entering test: testValidateIatAndExp_expFuture_withinClockSkew_iatFuture_withinClockSkew
Original string: [2018-09-06T02:01:48+0100]
Regex string   : [\Q2018-09-06T02:01:48+0100\E]
Original string: [2018-09-06T02:00:48+0100]
Regex string   : [\Q2018-09-06T02:00:48+0100\E]
Exiting test: testValidateIatAndExp_expFuture_withinClockSkew_iatFuture_withinClockSkew
Entering test: testValidateNbf_nullClaims
Exiting test: testValidateNbf_nullClaims
Entering test: testValidateNbf_nbfThrowsException
Exiting test: testValidateNbf_nbfThrowsException
Entering test: testValidateNbf_nullNbf
Exiting test: testValidateNbf_nullNbf
Entering test: testValidateNbf_pastNbf_outsideClockSkew
Exiting test: testValidateNbf_pastNbf_outsideClockSkew
Entering test: testValidateNbf_pastNbf_withinClockSkew
Exiting test: testValidateNbf_pastNbf_withinClockSkew
Entering test: testValidateNbf_futureNbf_withinClockSkew
Exiting test: testValidateNbf_futureNbf_withinClockSkew
Entering test: testValidateNbf_futureNbf_outsideClockSkew
Original string: [2018-09-06T02:59:48+0100]
Regex string   : [\Q2018-09-06T02:59:48+0100\E]
Exiting test: testValidateNbf_futureNbf_outsideClockSkew
Entering test: testGetAlgorithmHeader_nullContext
Exiting test: testGetAlgorithmHeader_nullContext
Entering test: testGetAlgorithmHeader_missingJsonWebStructures
Chose list: null
Exiting test: testGetAlgorithmHeader_missingJsonWebStructures
Entering test: testGetAlgorithmHeader_validAlgorithmHeader
Exiting test: testGetAlgorithmHeader_validAlgorithmHeader
Entering test: testValidateAlgorithm_nullArgs
Exiting test: testValidateAlgorithm_nullArgs
Entering test: testValidateAlgorithm_algMismatch
Exiting test: testValidateAlgorithm_algMismatch
Entering test: testValidateAlgorithm_algMatch
Exiting test: testValidateAlgorithm_algMatch

-- System.err -------------------------------------------------
-- Messages -------------------------------------------------
[06/09/18 01:59:48:366 BST] 00000012 SystemOut                                                    O Entering test: testValidateClaimsReadsConfigProperty
[06/09/18 01:59:48:377 BST] 00000012 SystemOut                                                    O Exiting test: testValidateClaimsReadsConfigProperty
[06/09/18 01:59:48:381 BST] 00000012 SystemOut                                                    O Entering test: testGetSigningKey_nullConfig
[06/09/18 01:59:48:382 BST] 00000012 SystemOut                                                    O Exiting test: testGetSigningKey_nullConfig
[06/09/18 01:59:48:384 BST] 00000012 SystemOut                                                    O Entering test: testGetSigningKey_unknownAlg
[06/09/18 01:59:48:407 BST] 00000012 SystemOut                                                    O Exiting test: testGetSigningKey_unknownAlg
[06/09/18 01:59:48:409 BST] 00000012 SystemOut                                                    O Entering test: testGetSigningKey_HS256ThrowsException
[06/09/18 01:59:48:415 BST] 00000012 SystemOut                                                    O Exiting test: testGetSigningKey_HS256ThrowsException
[06/09/18 01:59:48:418 BST] 00000012 SystemOut                                                    O Entering test: testGetSigningKey_HS256Valid
[06/09/18 01:59:48:420 BST] 00000012 SystemOut                                                    O Exiting test: testGetSigningKey_HS256Valid
[06/09/18 01:59:48:423 BST] 00000012 SystemOut                                                    O Entering test: testGetSigningKey_RS256ThrowsException
[06/09/18 01:59:48:426 BST] 00000012 SystemOut                                                    O Exiting test: testGetSigningKey_RS256ThrowsException
[06/09/18 01:59:48:428 BST] 00000012 SystemOut                                                    O Entering test: testGetSigningKey_RS256Valid
[06/09/18 01:59:48:470 BST] 00000012 SystemOut                                                    O Exiting test: testGetSigningKey_RS256Valid
[06/09/18 01:59:48:472 BST] 00000012 SystemOut                                                    O Entering test: testGetSharedSecretKey_nullConfig
[06/09/18 01:59:48:473 BST] 00000012 SystemOut                                                    O Exiting test: testGetSharedSecretKey_nullConfig
[06/09/18 01:59:48:475 BST] 00000012 SystemOut                                                    O Entering test: testGetSharedSecretKey_emptyOrNullKey
[06/09/18 01:59:48:477 BST] 00000012 SystemOut                                                    O Chose key: []
[06/09/18 01:59:48:478 BST] 00000012 SystemOut                                                    O Exiting test: testGetSharedSecretKey_emptyOrNullKey
[06/09/18 01:59:48:480 BST] 00000012 SystemOut                                                    O Entering test: testGetSharedSecretKey_validKey
[06/09/18 01:59:48:481 BST] 00000012 SystemOut                                                    O Exiting test: testGetSharedSecretKey_validKey
[06/09/18 01:59:48:485 BST] 00000012 SystemOut                                                    O Entering test: testGetPublicKey_missingKeyStoreService
[06/09/18 01:59:48:487 BST] 00000012 SystemOut                                                    O Exiting test: testGetPublicKey_missingKeyStoreService
[06/09/18 01:59:48:489 BST] 00000012 SystemOut                                                    O Entering test: testGetPublicKey_nullArgs
[06/09/18 01:59:48:520 BST] 00000012 SystemOut                                                    O Exiting test: testGetPublicKey_nullArgs
[06/09/18 01:59:48:522 BST] 00000012 SystemOut                                                    O Entering test: testGetPublicKey_throwsException
[06/09/18 01:59:48:525 BST] 00000012 SystemOut                                                    O Exiting test: testGetPublicKey_throwsException
[06/09/18 01:59:48:527 BST] 00000012 SystemOut                                                    O Entering test: testGetPublicKey_notRSAPublicKey
[06/09/18 01:59:48:529 BST] 00000012 SystemOut                                                    O Exiting test: testGetPublicKey_notRSAPublicKey
[06/09/18 01:59:48:532 BST] 00000012 SystemOut                                                    O Entering test: testGetPublicKey_validKey
[06/09/18 01:59:48:534 BST] 00000012 SystemOut                                                    O Exiting test: testGetPublicKey_validKey
[06/09/18 01:59:48:537 BST] 00000012 SystemOut                                                    O Entering test: testParseJwtWithoutValidation_nullOrEmptyTokenString
[06/09/18 01:59:48:539 BST] 00000012 SystemOut                                                    O Exiting test: testParseJwtWithoutValidation_nullOrEmptyTokenString
[06/09/18 01:59:48:540 BST] 00000012 SystemOut                                                    O Entering test: testParseJwtWithoutValidation_singlePartTokenString
[06/09/18 01:59:48:546 BST] 00000012 SystemOut                                                    O Exiting test: testParseJwtWithoutValidation_singlePartTokenString
[06/09/18 01:59:48:548 BST] 00000012 SystemOut                                                    O Entering test: testParseJwtWithoutValidation_twoPartTokenString
[06/09/18 01:59:48:550 BST] 00000012 SystemOut                                                    O Exiting test: testParseJwtWithoutValidation_twoPartTokenString
[06/09/18 01:59:48:551 BST] 00000012 SystemOut                                                    O Entering test: testParseJwtWithoutValidation_threePartMalformedTokenString
[06/09/18 01:59:48:562 BST] 00000012 SystemOut                                                    O Exiting test: testParseJwtWithoutValidation_threePartMalformedTokenString
[06/09/18 01:59:48:564 BST] 00000012 SystemOut                                                    O Entering test: testValidateIssuer_nullOrEmptyArgs
[06/09/18 01:59:48:566 BST] 00000012 SystemOut                                                    O Exiting test: testValidateIssuer_nullOrEmptyArgs
[06/09/18 01:59:48:569 BST] 00000012 SystemOut                                                    O Entering test: testValidateIssuer_whitespaceTrustedIssuers
[06/09/18 01:59:48:571 BST] 00000012 SystemOut                                                    O Exiting test: testValidateIssuer_whitespaceTrustedIssuers
[06/09/18 01:59:48:572 BST] 00000012 SystemOut                                                    O Entering test: testValidateIssuer_commaTrustedIssuers
[06/09/18 01:59:48:573 BST] 00000012 SystemOut                                                    O Exiting test: testValidateIssuer_commaTrustedIssuers
[06/09/18 01:59:48:575 BST] 00000012 SystemOut                                                    O Entering test: testValidateIssuer_singleTrustedIssuer_nullTokenIssuer
[06/09/18 01:59:48:576 BST] 00000012 SystemOut                                                    O Exiting test: testValidateIssuer_singleTrustedIssuer_nullTokenIssuer
[06/09/18 01:59:48:578 BST] 00000012 SystemOut                                                    O Entering test: testValidateIssuer_singleTrustedIssuer_emptyTokenIssuer
[06/09/18 01:59:48:579 BST] 00000012 SystemOut                                                    O Exiting test: testValidateIssuer_singleTrustedIssuer_emptyTokenIssuer
[06/09/18 01:59:48:581 BST] 00000012 SystemOut                                                    O Entering test: testValidateIssuer_singleTrustedIssuer_untrustedTokenIssuer
[06/09/18 01:59:48:582 BST] 00000012 SystemOut                                                    O Exiting test: testValidateIssuer_singleTrustedIssuer_untrustedTokenIssuer
[06/09/18 01:59:48:584 BST] 00000012 SystemOut                                                    O Entering test: testValidateIssuer_singleTrustedIssuer_tokenIssuerSubstringOfTrusted
[06/09/18 01:59:48:585 BST] 00000012 SystemOut                                                    O Exiting test: testValidateIssuer_singleTrustedIssuer_tokenIssuerSubstringOfTrusted
[06/09/18 01:59:48:593 BST] 00000012 SystemOut                                                    O Entering test: testValidateIssuer_singleTrustedIssuer_tokenIssuerSuperStringWithComma
[06/09/18 01:59:48:595 BST] 00000012 SystemOut                                                    O Exiting test: testValidateIssuer_singleTrustedIssuer_tokenIssuerSuperStringWithComma
[06/09/18 01:59:48:600 BST] 00000012 SystemOut                                                    O Entering test: testValidateIssuer_singleTrustedIssuer_tokenIssuerSuperStringWithSpace
[06/09/18 01:59:48:601 BST] 00000012 SystemOut                                                    O Exiting test: testValidateIssuer_singleTrustedIssuer_tokenIssuerSuperStringWithSpace
[06/09/18 01:59:48:603 BST] 00000012 SystemOut                                                    O Entering test: testValidateIssuer_singleTrustedIssuer_emptyTokenIssuer_trailingCommaTrusted
[06/09/18 01:59:48:604 BST] 00000012 SystemOut                                                    O Exiting test: testValidateIssuer_singleTrustedIssuer_emptyTokenIssuer_trailingCommaTrusted
[06/09/18 01:59:48:606 BST] 00000012 SystemOut                                                    O Entering test: testValidateIssuer_singleTrustedIssuer_emptyTokenIssuer_leadingAndTrailingCommaTrusted
[06/09/18 01:59:48:607 BST] 00000012 SystemOut                                                    O Exiting test: testValidateIssuer_singleTrustedIssuer_emptyTokenIssuer_leadingAndTrailingCommaTrusted
[06/09/18 01:59:48:609 BST] 00000012 SystemOut                                                    O Entering test: testValidateIssuer_singleTrustedIssuer
[06/09/18 01:59:48:610 BST] 00000012 SystemOut                                                    O Exiting test: testValidateIssuer_singleTrustedIssuer
[06/09/18 01:59:48:611 BST] 00000012 SystemOut                                                    O Entering test: testValidateIssuer_multipleTrustedIssuers_nullTokenIssuer
[06/09/18 01:59:48:613 BST] 00000012 SystemOut                                                    O Exiting test: testValidateIssuer_multipleTrustedIssuers_nullTokenIssuer
[06/09/18 01:59:48:614 BST] 00000012 SystemOut                                                    O Entering test: testValidateIssuer_multipleTrustedIssuers_emptyTokenIssuer
[06/09/18 01:59:48:616 BST] 00000012 SystemOut                                                    O Exiting test: testValidateIssuer_multipleTrustedIssuers_emptyTokenIssuer
[06/09/18 01:59:48:618 BST] 00000012 SystemOut                                                    O Entering test: testValidateIssuer_multipleTrustedIssuers_untrustedTokenIssuer
[06/09/18 01:59:48:620 BST] 00000012 SystemOut                                                    O Exiting test: testValidateIssuer_multipleTrustedIssuers_untrustedTokenIssuer
[06/09/18 01:59:48:621 BST] 00000012 SystemOut                                                    O Entering test: testValidateIssuer_multipleTrustedIssuers_tokenIssuerContainsTrustedIssuer
[06/09/18 01:59:48:624 BST] 00000012 SystemOut                                                    O Exiting test: testValidateIssuer_multipleTrustedIssuers_tokenIssuerContainsTrustedIssuer
[06/09/18 01:59:48:626 BST] 00000012 SystemOut                                                    O Entering test: testValidateIssuer_multipleTrustedIssuers_tokenIssuerWithComma
[06/09/18 01:59:48:627 BST] 00000012 SystemOut                                                    O Exiting test: testValidateIssuer_multipleTrustedIssuers_tokenIssuerWithComma
[06/09/18 01:59:48:628 BST] 00000012 SystemOut                                                    O Entering test: testValidateIssuer_multipleTrustedIssuers
[06/09/18 01:59:48:630 BST] 00000012 SystemOut                                                    O Exiting test: testValidateIssuer_multipleTrustedIssuers
[06/09/18 01:59:48:631 BST] 00000012 SystemOut                                                    O Entering test: testValidateIssuer_trustAllIssuers
[06/09/18 01:59:48:633 BST] 00000012 SystemOut                                                    O Exiting test: testValidateIssuer_trustAllIssuers
[06/09/18 01:59:48:636 BST] 00000012 SystemOut                                                    O Entering test: testValidateAudience
[06/09/18 01:59:48:636 BST] 00000012 SystemOut                                                    O Exiting test: testValidateAudience
[06/09/18 01:59:48:638 BST] 00000012 SystemOut                                                    O Entering test: testValidateIatAndExp_nullClaims
[06/09/18 01:59:48:639 BST] 00000012 SystemOut                                                    O Exiting test: testValidateIatAndExp_nullClaims
[06/09/18 01:59:48:641 BST] 00000012 SystemOut                                                    O Entering test: testValidateIatAndExp_malformedIat
[06/09/18 01:59:48:673 BST] 00000012 SystemOut                                                    O Exiting test: testValidateIatAndExp_malformedIat
[06/09/18 01:59:48:675 BST] 00000012 SystemOut                                                    O Entering test: testValidateIatAndExp_malformedExp
[06/09/18 01:59:48:676 BST] 00000012 SystemOut                                                    O Exiting test: testValidateIatAndExp_malformedExp
[06/09/18 01:59:48:678 BST] 00000012 SystemOut                                                    O Entering test: testValidateIatAndExp_nullIat
[06/09/18 01:59:48:684 BST] 00000012 SystemOut                                                    O Exiting test: testValidateIatAndExp_nullIat
[06/09/18 01:59:48:686 BST] 00000012 SystemOut                                                    O Entering test: testValidateIatAndExp_nullExp
[06/09/18 01:59:48:688 BST] 00000012 SystemOut                                                    O Exiting test: testValidateIatAndExp_nullExp
[06/09/18 01:59:48:690 BST] 00000012 SystemOut                                                    O Entering test: testValidateIatAndExp_iatPast_outsideClockSkew_expPast_outsideClockSkew
[06/09/18 01:59:48:694 BST] 00000012 SystemOut                                                    O Original string: [2018-09-06T01:00:48+0100]
[06/09/18 01:59:48:694 BST] 00000012 SystemOut                                                    O Regex string   : [\Q2018-09-06T01:00:48+0100\E]
[06/09/18 01:59:48:695 BST] 00000012 SystemOut                                                    O Exiting test: testValidateIatAndExp_iatPast_outsideClockSkew_expPast_outsideClockSkew
[06/09/18 01:59:48:698 BST] 00000012 SystemOut                                                    O Entering test: testValidateIatAndExp_expPast_outsideClockSkew_iatPast_outsideClockSkew
[06/09/18 01:59:48:701 BST] 00000012 SystemOut                                                    O Original string: [2018-09-06T01:00:48+0100]
[06/09/18 01:59:48:701 BST] 00000012 SystemOut                                                    O Regex string   : [\Q2018-09-06T01:00:48+0100\E]
[06/09/18 01:59:48:702 BST] 00000012 SystemOut                                                    O Original string: [2018-09-06T00:59:48+0100]
[06/09/18 01:59:48:702 BST] 00000012 SystemOut                                                    O Regex string   : [\Q2018-09-06T00:59:48+0100\E]
[06/09/18 01:59:48:703 BST] 00000012 SystemOut                                                    O Exiting test: testValidateIatAndExp_expPast_outsideClockSkew_iatPast_outsideClockSkew
[06/09/18 01:59:48:704 BST] 00000012 SystemOut                                                    O Entering test: testValidateIatAndExp_iatPast_outsideClockSkew_expPast_withinClockSkew
[06/09/18 01:59:48:707 BST] 00000012 SystemOut                                                    O Exiting test: testValidateIatAndExp_iatPast_outsideClockSkew_expPast_withinClockSkew
[06/09/18 01:59:48:708 BST] 00000012 SystemOut                                                    O Entering test: testValidateIatAndExp_expPast_outsideClockSkew_iatPast_withinClockSkew
[06/09/18 01:59:48:713 BST] 00000012 SystemOut                                                    O Original string: [2018-09-06T01:58:48+0100]
[06/09/18 01:59:48:713 BST] 00000012 SystemOut                                                    O Regex string   : [\Q2018-09-06T01:58:48+0100\E]
[06/09/18 01:59:48:714 BST] 00000012 SystemOut                                                    O Original string: [2018-09-06T00:59:48+0100]
[06/09/18 01:59:48:714 BST] 00000012 SystemOut                                                    O Regex string   : [\Q2018-09-06T00:59:48+0100\E]
[06/09/18 01:59:48:715 BST] 00000012 SystemOut                                                    O Exiting test: testValidateIatAndExp_expPast_outsideClockSkew_iatPast_withinClockSkew
[06/09/18 01:59:48:717 BST] 00000012 SystemOut                                                    O Entering test: testValidateIatAndExp_iatPast_withinClockSkew_expPast_withinClockSkew
[06/09/18 01:59:48:719 BST] 00000012 SystemOut                                                    O Exiting test: testValidateIatAndExp_iatPast_withinClockSkew_expPast_withinClockSkew
[06/09/18 01:59:48:721 BST] 00000012 SystemOut                                                    O Entering test: testValidateIatAndExp_expPast_withinClockSkew_iatPast_withinClockSkew
[06/09/18 01:59:48:724 BST] 00000012 SystemOut                                                    O Original string: [2018-09-06T01:58:48+0100]
[06/09/18 01:59:48:724 BST] 00000012 SystemOut                                                    O Regex string   : [\Q2018-09-06T01:58:48+0100\E]
[06/09/18 01:59:48:725 BST] 00000012 SystemOut                                                    O Original string: [2018-09-06T01:57:48+0100]
[06/09/18 01:59:48:725 BST] 00000012 SystemOut                                                    O Regex string   : [\Q2018-09-06T01:57:48+0100\E]
[06/09/18 01:59:48:726 BST] 00000012 SystemOut                                                    O Exiting test: testValidateIatAndExp_expPast_withinClockSkew_iatPast_withinClockSkew
[06/09/18 01:59:48:729 BST] 00000012 SystemOut                                                    O Entering test: testValidateIatAndExp_iatPast_expFuture
[06/09/18 01:59:48:731 BST] 00000012 SystemOut                                                    O Exiting test: testValidateIatAndExp_iatPast_expFuture
[06/09/18 01:59:48:733 BST] 00000012 SystemOut                                                    O Entering test: testValidateIatAndExp_expPast_iatFuture_outsideClockSkew
[06/09/18 01:59:48:736 BST] 00000012 SystemOut                                                    O Original string: [2018-09-06T02:59:48+0100]
[06/09/18 01:59:48:736 BST] 00000012 SystemOut                                                    O Regex string   : [\Q2018-09-06T02:59:48+0100\E]
[06/09/18 01:59:48:737 BST] 00000012 SystemOut                                                    O Exiting test: testValidateIatAndExp_expPast_iatFuture_outsideClockSkew
[06/09/18 01:59:48:739 BST] 00000012 SystemOut                                                    O Entering test: testValidateIatAndExp_expPast_iatFuture_withinClockSkew
[06/09/18 01:59:48:742 BST] 00000012 SystemOut                                                    O Original string: [2018-09-06T02:00:48+0100]
[06/09/18 01:59:48:742 BST] 00000012 SystemOut                                                    O Regex string   : [\Q2018-09-06T02:00:48+0100\E]
[06/09/18 01:59:48:743 BST] 00000012 SystemOut                                                    O Original string: [2018-09-06T01:58:48+0100]
[06/09/18 01:59:48:745 BST] 00000012 SystemOut                                                    O Regex string   : [\Q2018-09-06T01:58:48+0100\E]
[06/09/18 01:59:48:745 BST] 00000012 SystemOut                                                    O Exiting test: testValidateIatAndExp_expPast_iatFuture_withinClockSkew
[06/09/18 01:59:48:747 BST] 00000012 SystemOut                                                    O Entering test: testValidateIatAndExp_iatFuture_outsideClockSkew_expFuture_outsideClockSkew
[06/09/18 01:59:48:750 BST] 00000012 SystemOut                                                    O Original string: [2018-09-06T02:59:48+0100]
[06/09/18 01:59:48:751 BST] 00000012 SystemOut                                                    O Regex string   : [\Q2018-09-06T02:59:48+0100\E]
[06/09/18 01:59:48:751 BST] 00000012 SystemOut                                                    O Exiting test: testValidateIatAndExp_iatFuture_outsideClockSkew_expFuture_outsideClockSkew
[06/09/18 01:59:48:753 BST] 00000012 SystemOut                                                    O Entering test: testValidateIatAndExp_expFuture_outsideClockSkew_iatFuture_outsideClockSkew
[06/09/18 01:59:48:756 BST] 00000012 SystemOut                                                    O Original string: [2018-09-06T03:00:48+0100]
[06/09/18 01:59:48:756 BST] 00000012 SystemOut                                                    O Regex string   : [\Q2018-09-06T03:00:48+0100\E]
[06/09/18 01:59:48:757 BST] 00000012 SystemOut                                                    O Exiting test: testValidateIatAndExp_expFuture_outsideClockSkew_iatFuture_outsideClockSkew
[06/09/18 01:59:48:759 BST] 00000012 SystemOut                                                    O Entering test: testValidateIatAndExp_expFuture_withinClockSkew_iatFuture_outsideClockSkew
[06/09/18 01:59:48:763 BST] 00000012 SystemOut                                                    O Original string: [2018-09-06T02:59:48+0100]
[06/09/18 01:59:48:764 BST] 00000012 SystemOut                                                    O Regex string   : [\Q2018-09-06T02:59:48+0100\E]
[06/09/18 01:59:48:765 BST] 00000012 SystemOut                                                    O Exiting test: testValidateIatAndExp_expFuture_withinClockSkew_iatFuture_outsideClockSkew
[06/09/18 01:59:48:766 BST] 00000012 SystemOut                                                    O Entering test: testValidateIatAndExp_iatFuture_withinClockSkew_expFuture_outsideClockSkew
[06/09/18 01:59:48:769 BST] 00000012 SystemOut                                                    O Exiting test: testValidateIatAndExp_iatFuture_withinClockSkew_expFuture_outsideClockSkew
[06/09/18 01:59:48:770 BST] 00000012 SystemOut                                                    O Entering test: testValidateIatAndExp_iatFuture_withinClockSkew_expFuture_withinClockSkew
[06/09/18 01:59:48:772 BST] 00000012 SystemOut                                                    O Exiting test: testValidateIatAndExp_iatFuture_withinClockSkew_expFuture_withinClockSkew
[06/09/18 01:59:48:774 BST] 00000012 SystemOut                                                    O Entering test: testValidateIatAndExp_expFuture_withinClockSkew_iatFuture_withinClockSkew
[06/09/18 01:59:48:777 BST] 00000012 SystemOut                                                    O Original string: [2018-09-06T02:01:48+0100]
[06/09/18 01:59:48:777 BST] 00000012 SystemOut                                                    O Regex string   : [\Q2018-09-06T02:01:48+0100\E]
[06/09/18 01:59:48:778 BST] 00000012 SystemOut                                                    O Original string: [2018-09-06T02:00:48+0100]
[06/09/18 01:59:48:780 BST] 00000012 SystemOut                                                    O Regex string   : [\Q2018-09-06T02:00:48+0100\E]
[06/09/18 01:59:48:780 BST] 00000012 SystemOut                                                    O Exiting test: testValidateIatAndExp_expFuture_withinClockSkew_iatFuture_withinClockSkew
[06/09/18 01:59:48:782 BST] 00000012 SystemOut                                                    O Entering test: testValidateNbf_nullClaims
[06/09/18 01:59:48:783 BST] 00000012 SystemOut                                                    O Exiting test: testValidateNbf_nullClaims
[06/09/18 01:59:48:784 BST] 00000012 SystemOut                                                    O Entering test: testValidateNbf_nbfThrowsException
[06/09/18 01:59:48:785 BST] 00000012 SystemOut                                                    O Exiting test: testValidateNbf_nbfThrowsException
[06/09/18 01:59:48:787 BST] 00000012 SystemOut                                                    O Entering test: testValidateNbf_nullNbf
[06/09/18 01:59:48:788 BST] 00000012 SystemOut                                                    O Exiting test: testValidateNbf_nullNbf
[06/09/18 01:59:48:789 BST] 00000012 SystemOut                                                    O Entering test: testValidateNbf_pastNbf_outsideClockSkew
[06/09/18 01:59:48:790 BST] 00000012 SystemOut                                                    O Exiting test: testValidateNbf_pastNbf_outsideClockSkew
[06/09/18 01:59:48:792 BST] 00000012 SystemOut                                                    O Entering test: testValidateNbf_pastNbf_withinClockSkew
[06/09/18 01:59:48:792 BST] 00000012 SystemOut                                                    O Exiting test: testValidateNbf_pastNbf_withinClockSkew
[06/09/18 01:59:48:794 BST] 00000012 SystemOut                                                    O Entering test: testValidateNbf_futureNbf_withinClockSkew
[06/09/18 01:59:48:795 BST] 00000012 SystemOut                                                    O Exiting test: testValidateNbf_futureNbf_withinClockSkew
[06/09/18 01:59:48:796 BST] 00000012 SystemOut                                                    O Entering test: testValidateNbf_futureNbf_outsideClockSkew
[06/09/18 01:59:48:799 BST] 00000012 SystemOut                                                    O Original string: [2018-09-06T02:59:48+0100]
[06/09/18 01:59:48:800 BST] 00000012 SystemOut                                                    O Regex string   : [\Q2018-09-06T02:59:48+0100\E]
[06/09/18 01:59:48:800 BST] 00000012 SystemOut                                                    O Exiting test: testValidateNbf_futureNbf_outsideClockSkew
[06/09/18 01:59:48:802 BST] 00000012 SystemOut                                                    O Entering test: testGetAlgorithmHeader_nullContext
[06/09/18 01:59:48:802 BST] 00000012 SystemOut                                                    O Exiting test: testGetAlgorithmHeader_nullContext
[06/09/18 01:59:48:804 BST] 00000012 SystemOut                                                    O Entering test: testGetAlgorithmHeader_missingJsonWebStructures
[06/09/18 01:59:48:804 BST] 00000012 SystemOut                                                    O Chose list: null
[06/09/18 01:59:48:830 BST] 00000012 SystemOut                                                    O Exiting test: testGetAlgorithmHeader_missingJsonWebStructures
[06/09/18 01:59:48:831 BST] 00000012 SystemOut                                                    O Entering test: testGetAlgorithmHeader_validAlgorithmHeader
[06/09/18 01:59:48:836 BST] 00000012 SystemOut                                                    O Exiting test: testGetAlgorithmHeader_validAlgorithmHeader
[06/09/18 01:59:48:838 BST] 00000012 SystemOut                                                    O Entering test: testValidateAlgorithm_nullArgs
[06/09/18 01:59:48:839 BST] 00000012 SystemOut                                                    O Exiting test: testValidateAlgorithm_nullArgs
[06/09/18 01:59:48:841 BST] 00000012 SystemOut                                                    O Entering test: testValidateAlgorithm_algMismatch
[06/09/18 01:59:48:860 BST] 00000012 SystemOut                                                    O Exiting test: testValidateAlgorithm_algMismatch
[06/09/18 01:59:48:862 BST] 00000012 SystemOut                                                    O Entering test: testValidateAlgorithm_algMatch
[06/09/18 01:59:48:864 BST] 00000012 SystemOut                                                    O Exiting test: testValidateAlgorithm_algMatch

-- Trace -------------------------------------------------
[06/09/18 01:59:48:366 BST] 00000012 id=00000000 SystemOut                                                    O Entering test: testValidateClaimsReadsConfigProperty
[06/09/18 01:59:48:377 BST] 00000012 id=00000000 SystemOut                                                    O Exiting test: testValidateClaimsReadsConfigProperty
[06/09/18 01:59:48:381 BST] 00000012 id=00000000 SystemOut                                                    O Entering test: testGetSigningKey_nullConfig
[06/09/18 01:59:48:381 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 JWT consumer config object is null
[06/09/18 01:59:48:382 BST] 00000012 id=00000000 SystemOut                                                    O Exiting test: testGetSigningKey_nullConfig
[06/09/18 01:59:48:384 BST] 00000012 id=00000000 SystemOut                                                    O Entering test: testGetSigningKey_unknownAlg
[06/09/18 01:59:48:407 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 A signing key could not be found
[06/09/18 01:59:48:407 BST] 00000012 id=00000000 SystemOut                                                    O Exiting test: testGetSigningKey_unknownAlg
[06/09/18 01:59:48:409 BST] 00000012 id=00000000 SystemOut                                                    O Entering test: testGetSigningKey_HS256ThrowsException
[06/09/18 01:59:48:415 BST] 00000012 id=00000000 SystemOut                                                    O Exiting test: testGetSigningKey_HS256ThrowsException
[06/09/18 01:59:48:418 BST] 00000012 id=00000000 SystemOut                                                    O Entering test: testGetSigningKey_HS256Valid
[06/09/18 01:59:48:420 BST] 00000012 id=00000000 SystemOut                                                    O Exiting test: testGetSigningKey_HS256Valid
[06/09/18 01:59:48:423 BST] 00000012 id=00000000 SystemOut                                                    O Entering test: testGetSigningKey_RS256ThrowsException
[06/09/18 01:59:48:426 BST] 00000012 id=00000000 SystemOut                                                    O Exiting test: testGetSigningKey_RS256ThrowsException
[06/09/18 01:59:48:428 BST] 00000012 id=00000000 SystemOut                                                    O Entering test: testGetSigningKey_RS256Valid
[06/09/18 01:59:48:470 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Trusted alias: myAlias, Truststore: myTrustStore
[06/09/18 01:59:48:470 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 RSAPublicKey: true
[06/09/18 01:59:48:470 BST] 00000012 id=00000000 SystemOut                                                    O Exiting test: testGetSigningKey_RS256Valid
[06/09/18 01:59:48:472 BST] 00000012 id=00000000 SystemOut                                                    O Entering test: testGetSharedSecretKey_nullConfig
[06/09/18 01:59:48:473 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 JWT consumer config object is null
[06/09/18 01:59:48:473 BST] 00000012 id=00000000 SystemOut                                                    O Exiting test: testGetSharedSecretKey_nullConfig
[06/09/18 01:59:48:475 BST] 00000012 id=00000000 SystemOut                                                    O Entering test: testGetSharedSecretKey_emptyOrNullKey
[06/09/18 01:59:48:476 BST] 00000012 id=00000000 com.ibm.ws.security.common.random.RandomUtils                3 Chose random selection: []
[06/09/18 01:59:48:477 BST] 00000012 id=00000000 SystemOut                                                    O Chose key: []
[06/09/18 01:59:48:478 BST] 00000012 id=00000000 SystemOut                                                    O Exiting test: testGetSharedSecretKey_emptyOrNullKey
[06/09/18 01:59:48:480 BST] 00000012 id=00000000 SystemOut                                                    O Entering test: testGetSharedSecretKey_validKey
[06/09/18 01:59:48:481 BST] 00000012 id=00000000 SystemOut                                                    O Exiting test: testGetSharedSecretKey_validKey
[06/09/18 01:59:48:485 BST] 00000012 id=00000000 SystemOut                                                    O Entering test: testGetPublicKey_missingKeyStoreService
[06/09/18 01:59:48:485 BST] 00000012 id=00000000 com.ibm.ws.security.common.random.RandomUtils                3 Chose random selection: [null]
[06/09/18 01:59:48:487 BST] 00000012 id=00000000 SystemOut                                                    O Exiting test: testGetPublicKey_missingKeyStoreService
[06/09/18 01:59:48:489 BST] 00000012 id=00000000 SystemOut                                                    O Entering test: testGetPublicKey_nullArgs
[06/09/18 01:59:48:519 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Trusted alias: null, Truststore: null
[06/09/18 01:59:48:519 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 RSAPublicKey: false
[06/09/18 01:59:48:520 BST] 00000012 id=00000000 SystemOut                                                    O Exiting test: testGetPublicKey_nullArgs
[06/09/18 01:59:48:522 BST] 00000012 id=00000000 SystemOut                                                    O Entering test: testGetPublicKey_throwsException
[06/09/18 01:59:48:523 BST] 00000012 id=00000000 com.ibm.ws.security.common.random.RandomUtils                3 Chose random selection: [RS256]
[06/09/18 01:59:48:525 BST] 00000012 id=00000000 SystemOut                                                    O Exiting test: testGetPublicKey_throwsException
[06/09/18 01:59:48:527 BST] 00000012 id=00000000 SystemOut                                                    O Entering test: testGetPublicKey_notRSAPublicKey
[06/09/18 01:59:48:527 BST] 00000012 id=00000000 com.ibm.ws.security.common.random.RandomUtils                3 Chose random selection: [HS256]
[06/09/18 01:59:48:528 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Trusted alias: myAlias, Truststore: myTrustStore
[06/09/18 01:59:48:528 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 RSAPublicKey: false
[06/09/18 01:59:48:529 BST] 00000012 id=00000000 SystemOut                                                    O Exiting test: testGetPublicKey_notRSAPublicKey
[06/09/18 01:59:48:532 BST] 00000012 id=00000000 SystemOut                                                    O Entering test: testGetPublicKey_validKey
[06/09/18 01:59:48:532 BST] 00000012 id=00000000 com.ibm.ws.security.common.random.RandomUtils                3 Chose random selection: [RS256]
[06/09/18 01:59:48:533 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Trusted alias: myAlias, Truststore: myTrustStore
[06/09/18 01:59:48:533 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 RSAPublicKey: true
[06/09/18 01:59:48:534 BST] 00000012 id=00000000 SystemOut                                                    O Exiting test: testGetPublicKey_validKey
[06/09/18 01:59:48:537 BST] 00000012 id=00000000 SystemOut                                                    O Entering test: testParseJwtWithoutValidation_nullOrEmptyTokenString
[06/09/18 01:59:48:537 BST] 00000012 id=00000000 com.ibm.ws.security.common.random.RandomUtils                3 Chose random selection: [null]
[06/09/18 01:59:48:538 BST] 00000012 id=00000000 com.ibm.ws.security.common.random.RandomUtils                3 Chose random selection: []
[06/09/18 01:59:48:539 BST] 00000012 id=00000000 SystemOut                                                    O Exiting test: testParseJwtWithoutValidation_nullOrEmptyTokenString
[06/09/18 01:59:48:540 BST] 00000012 id=00000000 SystemOut                                                    O Entering test: testParseJwtWithoutValidation_singlePartTokenString
[06/09/18 01:59:48:546 BST] 00000012 id=00000000 SystemOut                                                    O Exiting test: testParseJwtWithoutValidation_singlePartTokenString
[06/09/18 01:59:48:548 BST] 00000012 id=00000000 SystemOut                                                    O Entering test: testParseJwtWithoutValidation_twoPartTokenString
[06/09/18 01:59:48:550 BST] 00000012 id=00000000 SystemOut                                                    O Exiting test: testParseJwtWithoutValidation_twoPartTokenString
[06/09/18 01:59:48:551 BST] 00000012 id=00000000 SystemOut                                                    O Entering test: testParseJwtWithoutValidation_threePartMalformedTokenString
[06/09/18 01:59:48:562 BST] 00000012 id=00000000 SystemOut                                                    O Exiting test: testParseJwtWithoutValidation_threePartMalformedTokenString
[06/09/18 01:59:48:564 BST] 00000012 id=00000000 SystemOut                                                    O Entering test: testValidateIssuer_nullOrEmptyArgs
[06/09/18 01:59:48:566 BST] 00000012 id=00000000 SystemOut                                                    O Exiting test: testValidateIssuer_nullOrEmptyArgs
[06/09/18 01:59:48:569 BST] 00000012 id=00000000 SystemOut                                                    O Entering test: testValidateIssuer_whitespaceTrustedIssuers
[06/09/18 01:59:48:570 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Trusted issuer: 
[06/09/18 01:59:48:571 BST] 00000012 id=00000000 SystemOut                                                    O Exiting test: testValidateIssuer_whitespaceTrustedIssuers
[06/09/18 01:59:48:572 BST] 00000012 id=00000000 SystemOut                                                    O Entering test: testValidateIssuer_commaTrustedIssuers
[06/09/18 01:59:48:573 BST] 00000012 id=00000000 SystemOut                                                    O Exiting test: testValidateIssuer_commaTrustedIssuers
[06/09/18 01:59:48:575 BST] 00000012 id=00000000 SystemOut                                                    O Entering test: testValidateIssuer_singleTrustedIssuer_nullTokenIssuer
[06/09/18 01:59:48:576 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Trusted issuer: entry1
[06/09/18 01:59:48:576 BST] 00000012 id=00000000 SystemOut                                                    O Exiting test: testValidateIssuer_singleTrustedIssuer_nullTokenIssuer
[06/09/18 01:59:48:578 BST] 00000012 id=00000000 SystemOut                                                    O Entering test: testValidateIssuer_singleTrustedIssuer_emptyTokenIssuer
[06/09/18 01:59:48:578 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Trusted issuer: entry1
[06/09/18 01:59:48:579 BST] 00000012 id=00000000 SystemOut                                                    O Exiting test: testValidateIssuer_singleTrustedIssuer_emptyTokenIssuer
[06/09/18 01:59:48:581 BST] 00000012 id=00000000 SystemOut                                                    O Entering test: testValidateIssuer_singleTrustedIssuer_untrustedTokenIssuer
[06/09/18 01:59:48:581 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Trusted issuer: entry1
[06/09/18 01:59:48:582 BST] 00000012 id=00000000 SystemOut                                                    O Exiting test: testValidateIssuer_singleTrustedIssuer_untrustedTokenIssuer
[06/09/18 01:59:48:584 BST] 00000012 id=00000000 SystemOut                                                    O Entering test: testValidateIssuer_singleTrustedIssuer_tokenIssuerSubstringOfTrusted
[06/09/18 01:59:48:584 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Trusted issuer: entry1entry2
[06/09/18 01:59:48:585 BST] 00000012 id=00000000 SystemOut                                                    O Exiting test: testValidateIssuer_singleTrustedIssuer_tokenIssuerSubstringOfTrusted
[06/09/18 01:59:48:593 BST] 00000012 id=00000000 SystemOut                                                    O Entering test: testValidateIssuer_singleTrustedIssuer_tokenIssuerSuperStringWithComma
[06/09/18 01:59:48:594 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Trusted issuer: entry1
[06/09/18 01:59:48:595 BST] 00000012 id=00000000 SystemOut                                                    O Exiting test: testValidateIssuer_singleTrustedIssuer_tokenIssuerSuperStringWithComma
[06/09/18 01:59:48:600 BST] 00000012 id=00000000 SystemOut                                                    O Entering test: testValidateIssuer_singleTrustedIssuer_tokenIssuerSuperStringWithSpace
[06/09/18 01:59:48:600 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Trusted issuer: entry1
[06/09/18 01:59:48:601 BST] 00000012 id=00000000 SystemOut                                                    O Exiting test: testValidateIssuer_singleTrustedIssuer_tokenIssuerSuperStringWithSpace
[06/09/18 01:59:48:603 BST] 00000012 id=00000000 SystemOut                                                    O Entering test: testValidateIssuer_singleTrustedIssuer_emptyTokenIssuer_trailingCommaTrusted
[06/09/18 01:59:48:603 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Trusted issuer: entry1
[06/09/18 01:59:48:604 BST] 00000012 id=00000000 SystemOut                                                    O Exiting test: testValidateIssuer_singleTrustedIssuer_emptyTokenIssuer_trailingCommaTrusted
[06/09/18 01:59:48:606 BST] 00000012 id=00000000 SystemOut                                                    O Entering test: testValidateIssuer_singleTrustedIssuer_emptyTokenIssuer_leadingAndTrailingCommaTrusted
[06/09/18 01:59:48:606 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Trusted issuer: entry1
[06/09/18 01:59:48:607 BST] 00000012 id=00000000 SystemOut                                                    O Exiting test: testValidateIssuer_singleTrustedIssuer_emptyTokenIssuer_leadingAndTrailingCommaTrusted
[06/09/18 01:59:48:609 BST] 00000012 id=00000000 SystemOut                                                    O Entering test: testValidateIssuer_singleTrustedIssuer
[06/09/18 01:59:48:609 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Trusted issuer: entry1
[06/09/18 01:59:48:609 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Trusted issuer: entry1
[06/09/18 01:59:48:609 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Trusted issuer: entry1
[06/09/18 01:59:48:609 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Trusted issuer: entry1
[06/09/18 01:59:48:610 BST] 00000012 id=00000000 SystemOut                                                    O Exiting test: testValidateIssuer_singleTrustedIssuer
[06/09/18 01:59:48:611 BST] 00000012 id=00000000 SystemOut                                                    O Entering test: testValidateIssuer_multipleTrustedIssuers_nullTokenIssuer
[06/09/18 01:59:48:612 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Trusted issuer: entry1
[06/09/18 01:59:48:612 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Trusted issuer: entry2
[06/09/18 01:59:48:613 BST] 00000012 id=00000000 SystemOut                                                    O Exiting test: testValidateIssuer_multipleTrustedIssuers_nullTokenIssuer
[06/09/18 01:59:48:614 BST] 00000012 id=00000000 SystemOut                                                    O Entering test: testValidateIssuer_multipleTrustedIssuers_emptyTokenIssuer
[06/09/18 01:59:48:615 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Trusted issuer: entry1
[06/09/18 01:59:48:615 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Trusted issuer: entry2
[06/09/18 01:59:48:616 BST] 00000012 id=00000000 SystemOut                                                    O Exiting test: testValidateIssuer_multipleTrustedIssuers_emptyTokenIssuer
[06/09/18 01:59:48:618 BST] 00000012 id=00000000 SystemOut                                                    O Entering test: testValidateIssuer_multipleTrustedIssuers_untrustedTokenIssuer
[06/09/18 01:59:48:619 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Trusted issuer: entry1
[06/09/18 01:59:48:619 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Trusted issuer: entry2
[06/09/18 01:59:48:620 BST] 00000012 id=00000000 SystemOut                                                    O Exiting test: testValidateIssuer_multipleTrustedIssuers_untrustedTokenIssuer
[06/09/18 01:59:48:621 BST] 00000012 id=00000000 SystemOut                                                    O Entering test: testValidateIssuer_multipleTrustedIssuers_tokenIssuerContainsTrustedIssuer
[06/09/18 01:59:48:623 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Trusted issuer: entry1
[06/09/18 01:59:48:623 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Trusted issuer: entry2
[06/09/18 01:59:48:624 BST] 00000012 id=00000000 SystemOut                                                    O Exiting test: testValidateIssuer_multipleTrustedIssuers_tokenIssuerContainsTrustedIssuer
[06/09/18 01:59:48:626 BST] 00000012 id=00000000 SystemOut                                                    O Entering test: testValidateIssuer_multipleTrustedIssuers_tokenIssuerWithComma
[06/09/18 01:59:48:626 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Trusted issuer: entry1
[06/09/18 01:59:48:626 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Trusted issuer: entry2
[06/09/18 01:59:48:627 BST] 00000012 id=00000000 SystemOut                                                    O Exiting test: testValidateIssuer_multipleTrustedIssuers_tokenIssuerWithComma
[06/09/18 01:59:48:628 BST] 00000012 id=00000000 SystemOut                                                    O Entering test: testValidateIssuer_multipleTrustedIssuers
[06/09/18 01:59:48:629 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Trusted issuer: entry1
[06/09/18 01:59:48:629 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Trusted issuer: entry1
[06/09/18 01:59:48:629 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Trusted issuer: http://localhost:80/context/sub
[06/09/18 01:59:48:629 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Trusted issuer: entry1
[06/09/18 01:59:48:629 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Trusted issuer: entry1
[06/09/18 01:59:48:630 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Trusted issuer: entry2
[06/09/18 01:59:48:630 BST] 00000012 id=00000000 SystemOut                                                    O Exiting test: testValidateIssuer_multipleTrustedIssuers
[06/09/18 01:59:48:631 BST] 00000012 id=00000000 SystemOut                                                    O Entering test: testValidateIssuer_trustAllIssuers
[06/09/18 01:59:48:632 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Trusted issuer: ALL_ISSUERS
[06/09/18 01:59:48:632 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Trusted issuer: ALL_ISSUERS
[06/09/18 01:59:48:632 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Trusted issuer: ALL_ISSUERS
[06/09/18 01:59:48:632 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Trusted issuer: ALL_ISSUERS
[06/09/18 01:59:48:632 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Trusted issuer: entry1
[06/09/18 01:59:48:633 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Trusted issuer: entry1 ALL_ISSUERS
[06/09/18 01:59:48:633 BST] 00000012 id=00000000 SystemOut                                                    O Exiting test: testValidateIssuer_trustAllIssuers
[06/09/18 01:59:48:636 BST] 00000012 id=00000000 SystemOut                                                    O Entering test: testValidateAudience
[06/09/18 01:59:48:636 BST] 00000012 id=00000000 SystemOut                                                    O Exiting test: testValidateAudience
[06/09/18 01:59:48:638 BST] 00000012 id=00000000 SystemOut                                                    O Entering test: testValidateIatAndExp_nullClaims
[06/09/18 01:59:48:639 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Missing JwtClaims object
[06/09/18 01:59:48:639 BST] 00000012 id=00000000 SystemOut                                                    O Exiting test: testValidateIatAndExp_nullClaims
[06/09/18 01:59:48:641 BST] 00000012 id=00000000 SystemOut                                                    O Entering test: testValidateIatAndExp_malformedIat
[06/09/18 01:59:48:673 BST] 00000012 id=00000000 SystemOut                                                    O Exiting test: testValidateIatAndExp_malformedIat
[06/09/18 01:59:48:675 BST] 00000012 id=00000000 SystemOut                                                    O Entering test: testValidateIatAndExp_malformedExp
[06/09/18 01:59:48:676 BST] 00000012 id=00000000 SystemOut                                                    O Exiting test: testValidateIatAndExp_malformedExp
[06/09/18 01:59:48:678 BST] 00000012 id=00000000 SystemOut                                                    O Entering test: testValidateIatAndExp_nullIat
[06/09/18 01:59:48:679 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536199188000
[06/09/18 01:59:48:683 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 02:59:48 BST 2018
[06/09/18 01:59:48:683 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Checking iat [null] and exp [2018-09-06T02:59:48+0100]
[06/09/18 01:59:48:683 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536195588000
[06/09/18 01:59:48:683 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 01:59:48 BST 2018
[06/09/18 01:59:48:684 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Comparing against current time (minus clock skew of 0 seconds) [2018-09-06T01:59:48+0100]
[06/09/18 01:59:48:684 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536195588000
[06/09/18 01:59:48:684 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 01:59:48 BST 2018
[06/09/18 01:59:48:684 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Comparing against current time (plus clock skew of 0 seconds) [2018-09-06T01:59:48+0100]
[06/09/18 01:59:48:684 BST] 00000012 id=00000000 SystemOut                                                    O Exiting test: testValidateIatAndExp_nullIat
[06/09/18 01:59:48:686 BST] 00000012 id=00000000 SystemOut                                                    O Entering test: testValidateIatAndExp_nullExp
[06/09/18 01:59:48:687 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536191988000
[06/09/18 01:59:48:687 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 00:59:48 BST 2018
[06/09/18 01:59:48:687 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Checking iat [2018-09-06T00:59:48+0100] and exp [null]
[06/09/18 01:59:48:687 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536195588000
[06/09/18 01:59:48:687 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 01:59:48 BST 2018
[06/09/18 01:59:48:687 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Comparing against current time (minus clock skew of 0 seconds) [2018-09-06T01:59:48+0100]
[06/09/18 01:59:48:687 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536195588000
[06/09/18 01:59:48:688 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 01:59:48 BST 2018
[06/09/18 01:59:48:688 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Comparing against current time (plus clock skew of 0 seconds) [2018-09-06T01:59:48+0100]
[06/09/18 01:59:48:688 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536195588000
[06/09/18 01:59:48:688 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 01:59:48 BST 2018
[06/09/18 01:59:48:688 BST] 00000012 id=00000000 SystemOut                                                    O Exiting test: testValidateIatAndExp_nullExp
[06/09/18 01:59:48:690 BST] 00000012 id=00000000 SystemOut                                                    O Entering test: testValidateIatAndExp_iatPast_outsideClockSkew_expPast_outsideClockSkew
[06/09/18 01:59:48:691 BST] 00000012 id=00000000 com.ibm.ws.security.common.random.RandomUtils                3 Chose random selection: [300000]
[06/09/18 01:59:48:691 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536191988000
[06/09/18 01:59:48:691 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 00:59:48 BST 2018
[06/09/18 01:59:48:692 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536192048000
[06/09/18 01:59:48:692 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 01:00:48 BST 2018
[06/09/18 01:59:48:692 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Checking iat [2018-09-06T00:59:48+0100] and exp [2018-09-06T01:00:48+0100]
[06/09/18 01:59:48:692 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536195288000
[06/09/18 01:59:48:692 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 01:54:48 BST 2018
[06/09/18 01:59:48:692 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Comparing against current time (minus clock skew of 300 seconds) [2018-09-06T01:54:48+0100]
[06/09/18 01:59:48:692 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536195888000
[06/09/18 01:59:48:692 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 02:04:48 BST 2018
[06/09/18 01:59:48:692 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Comparing against current time (plus clock skew of 300 seconds) [2018-09-06T02:04:48+0100]
[06/09/18 01:59:48:693 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536192048000
[06/09/18 01:59:48:693 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 01:00:48 BST 2018
[06/09/18 01:59:48:693 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536195288000
[06/09/18 01:59:48:693 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 01:54:48 BST 2018
[06/09/18 01:59:48:693 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536192048000
[06/09/18 01:59:48:693 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 01:00:48 BST 2018
[06/09/18 01:59:48:694 BST] 00000012 id=00000000 SystemOut                                                    O Original string: [2018-09-06T01:00:48+0100]
[06/09/18 01:59:48:694 BST] 00000012 id=00000000 SystemOut                                                    O Regex string   : [\Q2018-09-06T01:00:48+0100\E]
[06/09/18 01:59:48:695 BST] 00000012 id=00000000 SystemOut                                                    O Exiting test: testValidateIatAndExp_iatPast_outsideClockSkew_expPast_outsideClockSkew
[06/09/18 01:59:48:698 BST] 00000012 id=00000000 SystemOut                                                    O Entering test: testValidateIatAndExp_expPast_outsideClockSkew_iatPast_outsideClockSkew
[06/09/18 01:59:48:698 BST] 00000012 id=00000000 com.ibm.ws.security.common.random.RandomUtils                3 Chose random selection: [300000]
[06/09/18 01:59:48:699 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536192048000
[06/09/18 01:59:48:699 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 01:00:48 BST 2018
[06/09/18 01:59:48:699 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536191988000
[06/09/18 01:59:48:699 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 00:59:48 BST 2018
[06/09/18 01:59:48:699 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Checking iat [2018-09-06T01:00:48+0100] and exp [2018-09-06T00:59:48+0100]
[06/09/18 01:59:48:699 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536195288000
[06/09/18 01:59:48:699 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 01:54:48 BST 2018
[06/09/18 01:59:48:699 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Comparing against current time (minus clock skew of 300 seconds) [2018-09-06T01:54:48+0100]
[06/09/18 01:59:48:699 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536195888000
[06/09/18 01:59:48:700 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 02:04:48 BST 2018
[06/09/18 01:59:48:700 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Comparing against current time (plus clock skew of 300 seconds) [2018-09-06T02:04:48+0100]
[06/09/18 01:59:48:700 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536192048000
[06/09/18 01:59:48:700 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 01:00:48 BST 2018
[06/09/18 01:59:48:700 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536191988000
[06/09/18 01:59:48:700 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 00:59:48 BST 2018
[06/09/18 01:59:48:700 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536192048000
[06/09/18 01:59:48:701 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 01:00:48 BST 2018
[06/09/18 01:59:48:701 BST] 00000012 id=00000000 SystemOut                                                    O Original string: [2018-09-06T01:00:48+0100]
[06/09/18 01:59:48:701 BST] 00000012 id=00000000 SystemOut                                                    O Regex string   : [\Q2018-09-06T01:00:48+0100\E]
[06/09/18 01:59:48:701 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536191988000
[06/09/18 01:59:48:702 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 00:59:48 BST 2018
[06/09/18 01:59:48:702 BST] 00000012 id=00000000 SystemOut                                                    O Original string: [2018-09-06T00:59:48+0100]
[06/09/18 01:59:48:702 BST] 00000012 id=00000000 SystemOut                                                    O Regex string   : [\Q2018-09-06T00:59:48+0100\E]
[06/09/18 01:59:48:703 BST] 00000012 id=00000000 SystemOut                                                    O Exiting test: testValidateIatAndExp_expPast_outsideClockSkew_iatPast_outsideClockSkew
[06/09/18 01:59:48:704 BST] 00000012 id=00000000 SystemOut                                                    O Entering test: testValidateIatAndExp_iatPast_outsideClockSkew_expPast_withinClockSkew
[06/09/18 01:59:48:705 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536191988000
[06/09/18 01:59:48:705 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 00:59:48 BST 2018
[06/09/18 01:59:48:706 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536195528000
[06/09/18 01:59:48:706 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 01:58:48 BST 2018
[06/09/18 01:59:48:706 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Checking iat [2018-09-06T00:59:48+0100] and exp [2018-09-06T01:58:48+0100]
[06/09/18 01:59:48:706 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536195288000
[06/09/18 01:59:48:706 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 01:54:48 BST 2018
[06/09/18 01:59:48:706 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Comparing against current time (minus clock skew of 300 seconds) [2018-09-06T01:54:48+0100]
[06/09/18 01:59:48:706 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536195888000
[06/09/18 01:59:48:706 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 02:04:48 BST 2018
[06/09/18 01:59:48:707 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Comparing against current time (plus clock skew of 300 seconds) [2018-09-06T02:04:48+0100]
[06/09/18 01:59:48:707 BST] 00000012 id=00000000 SystemOut                                                    O Exiting test: testValidateIatAndExp_iatPast_outsideClockSkew_expPast_withinClockSkew
[06/09/18 01:59:48:708 BST] 00000012 id=00000000 SystemOut                                                    O Entering test: testValidateIatAndExp_expPast_outsideClockSkew_iatPast_withinClockSkew
[06/09/18 01:59:48:709 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536195528000
[06/09/18 01:59:48:709 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 01:58:48 BST 2018
[06/09/18 01:59:48:710 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536191988000
[06/09/18 01:59:48:710 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 00:59:48 BST 2018
[06/09/18 01:59:48:710 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Checking iat [2018-09-06T01:58:48+0100] and exp [2018-09-06T00:59:48+0100]
[06/09/18 01:59:48:710 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536195288000
[06/09/18 01:59:48:710 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 01:54:48 BST 2018
[06/09/18 01:59:48:710 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Comparing against current time (minus clock skew of 300 seconds) [2018-09-06T01:54:48+0100]
[06/09/18 01:59:48:710 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536195888000
[06/09/18 01:59:48:710 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 02:04:48 BST 2018
[06/09/18 01:59:48:710 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Comparing against current time (plus clock skew of 300 seconds) [2018-09-06T02:04:48+0100]
[06/09/18 01:59:48:711 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536195528000
[06/09/18 01:59:48:711 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 01:58:48 BST 2018
[06/09/18 01:59:48:711 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536191988000
[06/09/18 01:59:48:711 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 00:59:48 BST 2018
[06/09/18 01:59:48:713 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536195528000
[06/09/18 01:59:48:713 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 01:58:48 BST 2018
[06/09/18 01:59:48:713 BST] 00000012 id=00000000 SystemOut                                                    O Original string: [2018-09-06T01:58:48+0100]
[06/09/18 01:59:48:713 BST] 00000012 id=00000000 SystemOut                                                    O Regex string   : [\Q2018-09-06T01:58:48+0100\E]
[06/09/18 01:59:48:714 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536191988000
[06/09/18 01:59:48:714 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 00:59:48 BST 2018
[06/09/18 01:59:48:714 BST] 00000012 id=00000000 SystemOut                                                    O Original string: [2018-09-06T00:59:48+0100]
[06/09/18 01:59:48:714 BST] 00000012 id=00000000 SystemOut                                                    O Regex string   : [\Q2018-09-06T00:59:48+0100\E]
[06/09/18 01:59:48:715 BST] 00000012 id=00000000 SystemOut                                                    O Exiting test: testValidateIatAndExp_expPast_outsideClockSkew_iatPast_withinClockSkew
[06/09/18 01:59:48:717 BST] 00000012 id=00000000 SystemOut                                                    O Entering test: testValidateIatAndExp_iatPast_withinClockSkew_expPast_withinClockSkew
[06/09/18 01:59:48:718 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536195468000
[06/09/18 01:59:48:718 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 01:57:48 BST 2018
[06/09/18 01:59:48:718 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536195528000
[06/09/18 01:59:48:718 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 01:58:48 BST 2018
[06/09/18 01:59:48:718 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Checking iat [2018-09-06T01:57:48+0100] and exp [2018-09-06T01:58:48+0100]
[06/09/18 01:59:48:718 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536195288000
[06/09/18 01:59:48:719 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 01:54:48 BST 2018
[06/09/18 01:59:48:719 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Comparing against current time (minus clock skew of 300 seconds) [2018-09-06T01:54:48+0100]
[06/09/18 01:59:48:719 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536195888000
[06/09/18 01:59:48:719 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 02:04:48 BST 2018
[06/09/18 01:59:48:719 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Comparing against current time (plus clock skew of 300 seconds) [2018-09-06T02:04:48+0100]
[06/09/18 01:59:48:719 BST] 00000012 id=00000000 SystemOut                                                    O Exiting test: testValidateIatAndExp_iatPast_withinClockSkew_expPast_withinClockSkew
[06/09/18 01:59:48:721 BST] 00000012 id=00000000 SystemOut                                                    O Entering test: testValidateIatAndExp_expPast_withinClockSkew_iatPast_withinClockSkew
[06/09/18 01:59:48:722 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536195528000
[06/09/18 01:59:48:722 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 01:58:48 BST 2018
[06/09/18 01:59:48:722 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536195468000
[06/09/18 01:59:48:722 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 01:57:48 BST 2018
[06/09/18 01:59:48:722 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Checking iat [2018-09-06T01:58:48+0100] and exp [2018-09-06T01:57:48+0100]
[06/09/18 01:59:48:722 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536195288000
[06/09/18 01:59:48:722 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 01:54:48 BST 2018
[06/09/18 01:59:48:723 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Comparing against current time (minus clock skew of 300 seconds) [2018-09-06T01:54:48+0100]
[06/09/18 01:59:48:723 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536195888000
[06/09/18 01:59:48:723 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 02:04:48 BST 2018
[06/09/18 01:59:48:723 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Comparing against current time (plus clock skew of 300 seconds) [2018-09-06T02:04:48+0100]
[06/09/18 01:59:48:723 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536195528000
[06/09/18 01:59:48:723 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 01:58:48 BST 2018
[06/09/18 01:59:48:723 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536195468000
[06/09/18 01:59:48:723 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 01:57:48 BST 2018
[06/09/18 01:59:48:724 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536195528000
[06/09/18 01:59:48:724 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 01:58:48 BST 2018
[06/09/18 01:59:48:724 BST] 00000012 id=00000000 SystemOut                                                    O Original string: [2018-09-06T01:58:48+0100]
[06/09/18 01:59:48:724 BST] 00000012 id=00000000 SystemOut                                                    O Regex string   : [\Q2018-09-06T01:58:48+0100\E]
[06/09/18 01:59:48:725 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536195468000
[06/09/18 01:59:48:725 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 01:57:48 BST 2018
[06/09/18 01:59:48:725 BST] 00000012 id=00000000 SystemOut                                                    O Original string: [2018-09-06T01:57:48+0100]
[06/09/18 01:59:48:725 BST] 00000012 id=00000000 SystemOut                                                    O Regex string   : [\Q2018-09-06T01:57:48+0100\E]
[06/09/18 01:59:48:726 BST] 00000012 id=00000000 SystemOut                                                    O Exiting test: testValidateIatAndExp_expPast_withinClockSkew_iatPast_withinClockSkew
[06/09/18 01:59:48:729 BST] 00000012 id=00000000 SystemOut                                                    O Entering test: testValidateIatAndExp_iatPast_expFuture
[06/09/18 01:59:48:729 BST] 00000012 id=00000000 com.ibm.ws.security.common.random.RandomUtils                3 Chose random selection: [300000]
[06/09/18 01:59:48:729 BST] 00000012 id=00000000 com.ibm.ws.security.common.random.RandomUtils                3 Chose random selection: [-60000]
[06/09/18 01:59:48:730 BST] 00000012 id=00000000 com.ibm.ws.security.common.random.RandomUtils                3 Chose random selection: [3600000]
[06/09/18 01:59:48:730 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536195528000
[06/09/18 01:59:48:730 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 01:58:48 BST 2018
[06/09/18 01:59:48:730 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536199188000
[06/09/18 01:59:48:730 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 02:59:48 BST 2018
[06/09/18 01:59:48:730 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Checking iat [2018-09-06T01:58:48+0100] and exp [2018-09-06T02:59:48+0100]
[06/09/18 01:59:48:731 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536195288000
[06/09/18 01:59:48:731 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 01:54:48 BST 2018
[06/09/18 01:59:48:731 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Comparing against current time (minus clock skew of 300 seconds) [2018-09-06T01:54:48+0100]
[06/09/18 01:59:48:731 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536195888000
[06/09/18 01:59:48:731 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 02:04:48 BST 2018
[06/09/18 01:59:48:731 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Comparing against current time (plus clock skew of 300 seconds) [2018-09-06T02:04:48+0100]
[06/09/18 01:59:48:731 BST] 00000012 id=00000000 SystemOut                                                    O Exiting test: testValidateIatAndExp_iatPast_expFuture
[06/09/18 01:59:48:733 BST] 00000012 id=00000000 SystemOut                                                    O Entering test: testValidateIatAndExp_expPast_iatFuture_outsideClockSkew
[06/09/18 01:59:48:733 BST] 00000012 id=00000000 com.ibm.ws.security.common.random.RandomUtils                3 Chose random selection: [0]
[06/09/18 01:59:48:734 BST] 00000012 id=00000000 com.ibm.ws.security.common.random.RandomUtils                3 Chose random selection: [-60000]
[06/09/18 01:59:48:734 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536199188000
[06/09/18 01:59:48:734 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 02:59:48 BST 2018
[06/09/18 01:59:48:734 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536195528000
[06/09/18 01:59:48:734 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 01:58:48 BST 2018
[06/09/18 01:59:48:734 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Checking iat [2018-09-06T02:59:48+0100] and exp [2018-09-06T01:58:48+0100]
[06/09/18 01:59:48:734 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536195588000
[06/09/18 01:59:48:735 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 01:59:48 BST 2018
[06/09/18 01:59:48:735 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Comparing against current time (minus clock skew of 0 seconds) [2018-09-06T01:59:48+0100]
[06/09/18 01:59:48:735 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536195588000
[06/09/18 01:59:48:735 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 01:59:48 BST 2018
[06/09/18 01:59:48:735 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Comparing against current time (plus clock skew of 0 seconds) [2018-09-06T01:59:48+0100]
[06/09/18 01:59:48:735 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536199188000
[06/09/18 01:59:48:735 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 02:59:48 BST 2018
[06/09/18 01:59:48:735 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536195588000
[06/09/18 01:59:48:735 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 01:59:48 BST 2018
[06/09/18 01:59:48:736 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536199188000
[06/09/18 01:59:48:736 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 02:59:48 BST 2018
[06/09/18 01:59:48:736 BST] 00000012 id=00000000 SystemOut                                                    O Original string: [2018-09-06T02:59:48+0100]
[06/09/18 01:59:48:736 BST] 00000012 id=00000000 SystemOut                                                    O Regex string   : [\Q2018-09-06T02:59:48+0100\E]
[06/09/18 01:59:48:737 BST] 00000012 id=00000000 SystemOut                                                    O Exiting test: testValidateIatAndExp_expPast_iatFuture_outsideClockSkew
[06/09/18 01:59:48:739 BST] 00000012 id=00000000 SystemOut                                                    O Entering test: testValidateIatAndExp_expPast_iatFuture_withinClockSkew
[06/09/18 01:59:48:739 BST] 00000012 id=00000000 com.ibm.ws.security.common.random.RandomUtils                3 Chose random selection: [-60000]
[06/09/18 01:59:48:740 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536195648000
[06/09/18 01:59:48:740 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 02:00:48 BST 2018
[06/09/18 01:59:48:740 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536195528000
[06/09/18 01:59:48:740 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 01:58:48 BST 2018
[06/09/18 01:59:48:740 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Checking iat [2018-09-06T02:00:48+0100] and exp [2018-09-06T01:58:48+0100]
[06/09/18 01:59:48:740 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536195288000
[06/09/18 01:59:48:741 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 01:54:48 BST 2018
[06/09/18 01:59:48:741 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Comparing against current time (minus clock skew of 300 seconds) [2018-09-06T01:54:48+0100]
[06/09/18 01:59:48:741 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536195888000
[06/09/18 01:59:48:741 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 02:04:48 BST 2018
[06/09/18 01:59:48:741 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Comparing against current time (plus clock skew of 300 seconds) [2018-09-06T02:04:48+0100]
[06/09/18 01:59:48:741 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536195648000
[06/09/18 01:59:48:741 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 02:00:48 BST 2018
[06/09/18 01:59:48:741 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536195528000
[06/09/18 01:59:48:741 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 01:58:48 BST 2018
[06/09/18 01:59:48:742 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536195648000
[06/09/18 01:59:48:742 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 02:00:48 BST 2018
[06/09/18 01:59:48:742 BST] 00000012 id=00000000 SystemOut                                                    O Original string: [2018-09-06T02:00:48+0100]
[06/09/18 01:59:48:742 BST] 00000012 id=00000000 SystemOut                                                    O Regex string   : [\Q2018-09-06T02:00:48+0100\E]
[06/09/18 01:59:48:743 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536195528000
[06/09/18 01:59:48:743 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 01:58:48 BST 2018
[06/09/18 01:59:48:743 BST] 00000012 id=00000000 SystemOut                                                    O Original string: [2018-09-06T01:58:48+0100]
[06/09/18 01:59:48:745 BST] 00000012 id=00000000 SystemOut                                                    O Regex string   : [\Q2018-09-06T01:58:48+0100\E]
[06/09/18 01:59:48:745 BST] 00000012 id=00000000 SystemOut                                                    O Exiting test: testValidateIatAndExp_expPast_iatFuture_withinClockSkew
[06/09/18 01:59:48:747 BST] 00000012 id=00000000 SystemOut                                                    O Entering test: testValidateIatAndExp_iatFuture_outsideClockSkew_expFuture_outsideClockSkew
[06/09/18 01:59:48:748 BST] 00000012 id=00000000 com.ibm.ws.security.common.random.RandomUtils                3 Chose random selection: [0]
[06/09/18 01:59:48:748 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536199188000
[06/09/18 01:59:48:748 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 02:59:48 BST 2018
[06/09/18 01:59:48:748 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536199248000
[06/09/18 01:59:48:748 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 03:00:48 BST 2018
[06/09/18 01:59:48:749 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Checking iat [2018-09-06T02:59:48+0100] and exp [2018-09-06T03:00:48+0100]
[06/09/18 01:59:48:749 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536195588000
[06/09/18 01:59:48:749 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 01:59:48 BST 2018
[06/09/18 01:59:48:749 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Comparing against current time (minus clock skew of 0 seconds) [2018-09-06T01:59:48+0100]
[06/09/18 01:59:48:749 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536195588000
[06/09/18 01:59:48:749 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 01:59:48 BST 2018
[06/09/18 01:59:48:749 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Comparing against current time (plus clock skew of 0 seconds) [2018-09-06T01:59:48+0100]
[06/09/18 01:59:48:749 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536199188000
[06/09/18 01:59:48:749 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 02:59:48 BST 2018
[06/09/18 01:59:48:749 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536195588000
[06/09/18 01:59:48:750 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 01:59:48 BST 2018
[06/09/18 01:59:48:750 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536199188000
[06/09/18 01:59:48:750 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 02:59:48 BST 2018
[06/09/18 01:59:48:750 BST] 00000012 id=00000000 SystemOut                                                    O Original string: [2018-09-06T02:59:48+0100]
[06/09/18 01:59:48:751 BST] 00000012 id=00000000 SystemOut                                                    O Regex string   : [\Q2018-09-06T02:59:48+0100\E]
[06/09/18 01:59:48:751 BST] 00000012 id=00000000 SystemOut                                                    O Exiting test: testValidateIatAndExp_iatFuture_outsideClockSkew_expFuture_outsideClockSkew
[06/09/18 01:59:48:753 BST] 00000012 id=00000000 SystemOut                                                    O Entering test: testValidateIatAndExp_expFuture_outsideClockSkew_iatFuture_outsideClockSkew
[06/09/18 01:59:48:753 BST] 00000012 id=00000000 com.ibm.ws.security.common.random.RandomUtils                3 Chose random selection: [300000]
[06/09/18 01:59:48:754 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536199248000
[06/09/18 01:59:48:754 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 03:00:48 BST 2018
[06/09/18 01:59:48:754 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536199188000
[06/09/18 01:59:48:754 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 02:59:48 BST 2018
[06/09/18 01:59:48:754 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Checking iat [2018-09-06T03:00:48+0100] and exp [2018-09-06T02:59:48+0100]
[06/09/18 01:59:48:754 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536195288000
[06/09/18 01:59:48:754 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 01:54:48 BST 2018
[06/09/18 01:59:48:755 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Comparing against current time (minus clock skew of 300 seconds) [2018-09-06T01:54:48+0100]
[06/09/18 01:59:48:755 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536195888000
[06/09/18 01:59:48:755 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 02:04:48 BST 2018
[06/09/18 01:59:48:755 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Comparing against current time (plus clock skew of 300 seconds) [2018-09-06T02:04:48+0100]
[06/09/18 01:59:48:755 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536199248000
[06/09/18 01:59:48:755 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 03:00:48 BST 2018
[06/09/18 01:59:48:755 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536195888000
[06/09/18 01:59:48:755 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 02:04:48 BST 2018
[06/09/18 01:59:48:756 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536199248000
[06/09/18 01:59:48:756 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 03:00:48 BST 2018
[06/09/18 01:59:48:756 BST] 00000012 id=00000000 SystemOut                                                    O Original string: [2018-09-06T03:00:48+0100]
[06/09/18 01:59:48:756 BST] 00000012 id=00000000 SystemOut                                                    O Regex string   : [\Q2018-09-06T03:00:48+0100\E]
[06/09/18 01:59:48:757 BST] 00000012 id=00000000 SystemOut                                                    O Exiting test: testValidateIatAndExp_expFuture_outsideClockSkew_iatFuture_outsideClockSkew
[06/09/18 01:59:48:759 BST] 00000012 id=00000000 SystemOut                                                    O Entering test: testValidateIatAndExp_expFuture_withinClockSkew_iatFuture_outsideClockSkew
[06/09/18 01:59:48:761 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536199188000
[06/09/18 01:59:48:761 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 02:59:48 BST 2018
[06/09/18 01:59:48:762 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536195648000
[06/09/18 01:59:48:762 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 02:00:48 BST 2018
[06/09/18 01:59:48:762 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Checking iat [2018-09-06T02:59:48+0100] and exp [2018-09-06T02:00:48+0100]
[06/09/18 01:59:48:762 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536195288000
[06/09/18 01:59:48:762 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 01:54:48 BST 2018
[06/09/18 01:59:48:762 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Comparing against current time (minus clock skew of 300 seconds) [2018-09-06T01:54:48+0100]
[06/09/18 01:59:48:762 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536195888000
[06/09/18 01:59:48:762 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 02:04:48 BST 2018
[06/09/18 01:59:48:762 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Comparing against current time (plus clock skew of 300 seconds) [2018-09-06T02:04:48+0100]
[06/09/18 01:59:48:763 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536199188000
[06/09/18 01:59:48:763 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 02:59:48 BST 2018
[06/09/18 01:59:48:763 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536195888000
[06/09/18 01:59:48:763 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 02:04:48 BST 2018
[06/09/18 01:59:48:763 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536199188000
[06/09/18 01:59:48:763 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 02:59:48 BST 2018
[06/09/18 01:59:48:763 BST] 00000012 id=00000000 SystemOut                                                    O Original string: [2018-09-06T02:59:48+0100]
[06/09/18 01:59:48:764 BST] 00000012 id=00000000 SystemOut                                                    O Regex string   : [\Q2018-09-06T02:59:48+0100\E]
[06/09/18 01:59:48:765 BST] 00000012 id=00000000 SystemOut                                                    O Exiting test: testValidateIatAndExp_expFuture_withinClockSkew_iatFuture_outsideClockSkew
[06/09/18 01:59:48:766 BST] 00000012 id=00000000 SystemOut                                                    O Entering test: testValidateIatAndExp_iatFuture_withinClockSkew_expFuture_outsideClockSkew
[06/09/18 01:59:48:767 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536195648000
[06/09/18 01:59:48:767 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 02:00:48 BST 2018
[06/09/18 01:59:48:768 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536199188000
[06/09/18 01:59:48:768 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 02:59:48 BST 2018
[06/09/18 01:59:48:768 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Checking iat [2018-09-06T02:00:48+0100] and exp [2018-09-06T02:59:48+0100]
[06/09/18 01:59:48:768 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536195288000
[06/09/18 01:59:48:768 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 01:54:48 BST 2018
[06/09/18 01:59:48:768 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Comparing against current time (minus clock skew of 300 seconds) [2018-09-06T01:54:48+0100]
[06/09/18 01:59:48:768 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536195888000
[06/09/18 01:59:48:768 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 02:04:48 BST 2018
[06/09/18 01:59:48:768 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Comparing against current time (plus clock skew of 300 seconds) [2018-09-06T02:04:48+0100]
[06/09/18 01:59:48:769 BST] 00000012 id=00000000 SystemOut                                                    O Exiting test: testValidateIatAndExp_iatFuture_withinClockSkew_expFuture_outsideClockSkew
[06/09/18 01:59:48:770 BST] 00000012 id=00000000 SystemOut                                                    O Entering test: testValidateIatAndExp_iatFuture_withinClockSkew_expFuture_withinClockSkew
[06/09/18 01:59:48:771 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536195648000
[06/09/18 01:59:48:771 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 02:00:48 BST 2018
[06/09/18 01:59:48:771 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536195708000
[06/09/18 01:59:48:772 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 02:01:48 BST 2018
[06/09/18 01:59:48:772 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Checking iat [2018-09-06T02:00:48+0100] and exp [2018-09-06T02:01:48+0100]
[06/09/18 01:59:48:772 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536195288000
[06/09/18 01:59:48:772 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 01:54:48 BST 2018
[06/09/18 01:59:48:772 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Comparing against current time (minus clock skew of 300 seconds) [2018-09-06T01:54:48+0100]
[06/09/18 01:59:48:772 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536195888000
[06/09/18 01:59:48:772 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 02:04:48 BST 2018
[06/09/18 01:59:48:772 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Comparing against current time (plus clock skew of 300 seconds) [2018-09-06T02:04:48+0100]
[06/09/18 01:59:48:772 BST] 00000012 id=00000000 SystemOut                                                    O Exiting test: testValidateIatAndExp_iatFuture_withinClockSkew_expFuture_withinClockSkew
[06/09/18 01:59:48:774 BST] 00000012 id=00000000 SystemOut                                                    O Entering test: testValidateIatAndExp_expFuture_withinClockSkew_iatFuture_withinClockSkew
[06/09/18 01:59:48:775 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536195708000
[06/09/18 01:59:48:775 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 02:01:48 BST 2018
[06/09/18 01:59:48:775 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536195648000
[06/09/18 01:59:48:775 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 02:00:48 BST 2018
[06/09/18 01:59:48:775 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Checking iat [2018-09-06T02:01:48+0100] and exp [2018-09-06T02:00:48+0100]
[06/09/18 01:59:48:776 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536195288000
[06/09/18 01:59:48:776 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 01:54:48 BST 2018
[06/09/18 01:59:48:776 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Comparing against current time (minus clock skew of 300 seconds) [2018-09-06T01:54:48+0100]
[06/09/18 01:59:48:776 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536195888000
[06/09/18 01:59:48:776 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 02:04:48 BST 2018
[06/09/18 01:59:48:776 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Comparing against current time (plus clock skew of 300 seconds) [2018-09-06T02:04:48+0100]
[06/09/18 01:59:48:776 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536195708000
[06/09/18 01:59:48:776 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 02:01:48 BST 2018
[06/09/18 01:59:48:776 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536195648000
[06/09/18 01:59:48:776 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 02:00:48 BST 2018
[06/09/18 01:59:48:777 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536195708000
[06/09/18 01:59:48:777 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 02:01:48 BST 2018
[06/09/18 01:59:48:777 BST] 00000012 id=00000000 SystemOut                                                    O Original string: [2018-09-06T02:01:48+0100]
[06/09/18 01:59:48:777 BST] 00000012 id=00000000 SystemOut                                                    O Regex string   : [\Q2018-09-06T02:01:48+0100\E]
[06/09/18 01:59:48:778 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536195648000
[06/09/18 01:59:48:778 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 02:00:48 BST 2018
[06/09/18 01:59:48:778 BST] 00000012 id=00000000 SystemOut                                                    O Original string: [2018-09-06T02:00:48+0100]
[06/09/18 01:59:48:780 BST] 00000012 id=00000000 SystemOut                                                    O Regex string   : [\Q2018-09-06T02:00:48+0100\E]
[06/09/18 01:59:48:780 BST] 00000012 id=00000000 SystemOut                                                    O Exiting test: testValidateIatAndExp_expFuture_withinClockSkew_iatFuture_withinClockSkew
[06/09/18 01:59:48:782 BST] 00000012 id=00000000 SystemOut                                                    O Entering test: testValidateNbf_nullClaims
[06/09/18 01:59:48:782 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Missing JwtClaims object
[06/09/18 01:59:48:783 BST] 00000012 id=00000000 SystemOut                                                    O Exiting test: testValidateNbf_nullClaims
[06/09/18 01:59:48:784 BST] 00000012 id=00000000 SystemOut                                                    O Entering test: testValidateNbf_nbfThrowsException
[06/09/18 01:59:48:785 BST] 00000012 id=00000000 SystemOut                                                    O Exiting test: testValidateNbf_nbfThrowsException
[06/09/18 01:59:48:787 BST] 00000012 id=00000000 SystemOut                                                    O Entering test: testValidateNbf_nullNbf
[06/09/18 01:59:48:788 BST] 00000012 id=00000000 SystemOut                                                    O Exiting test: testValidateNbf_nullNbf
[06/09/18 01:59:48:789 BST] 00000012 id=00000000 SystemOut                                                    O Entering test: testValidateNbf_pastNbf_outsideClockSkew
[06/09/18 01:59:48:790 BST] 00000012 id=00000000 com.ibm.ws.security.common.random.RandomUtils                3 Chose random selection: [0]
[06/09/18 01:59:48:790 BST] 00000012 id=00000000 SystemOut                                                    O Exiting test: testValidateNbf_pastNbf_outsideClockSkew
[06/09/18 01:59:48:792 BST] 00000012 id=00000000 SystemOut                                                    O Entering test: testValidateNbf_pastNbf_withinClockSkew
[06/09/18 01:59:48:792 BST] 00000012 id=00000000 SystemOut                                                    O Exiting test: testValidateNbf_pastNbf_withinClockSkew
[06/09/18 01:59:48:794 BST] 00000012 id=00000000 SystemOut                                                    O Entering test: testValidateNbf_futureNbf_withinClockSkew
[06/09/18 01:59:48:795 BST] 00000012 id=00000000 SystemOut                                                    O Exiting test: testValidateNbf_futureNbf_withinClockSkew
[06/09/18 01:59:48:796 BST] 00000012 id=00000000 SystemOut                                                    O Entering test: testValidateNbf_futureNbf_outsideClockSkew
[06/09/18 01:59:48:798 BST] 00000012 id=00000000 com.ibm.ws.security.common.random.RandomUtils                3 Chose random selection: [300000]
[06/09/18 01:59:48:798 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536199188000
[06/09/18 01:59:48:799 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 02:59:48 BST 2018
[06/09/18 01:59:48:799 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536195888000
[06/09/18 01:59:48:799 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 02:04:48 BST 2018
[06/09/18 01:59:48:799 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on long value: 1536199188000
[06/09/18 01:59:48:799 BST] 00000012 id=00000000 com.ibm.ws.security.common.time.TimeUtils                    3 Creating date string based on date: Thu Sep 06 02:59:48 BST 2018
[06/09/18 01:59:48:799 BST] 00000012 id=00000000 SystemOut                                                    O Original string: [2018-09-06T02:59:48+0100]
[06/09/18 01:59:48:800 BST] 00000012 id=00000000 SystemOut                                                    O Regex string   : [\Q2018-09-06T02:59:48+0100\E]
[06/09/18 01:59:48:800 BST] 00000012 id=00000000 SystemOut                                                    O Exiting test: testValidateNbf_futureNbf_outsideClockSkew
[06/09/18 01:59:48:802 BST] 00000012 id=00000000 SystemOut                                                    O Entering test: testGetAlgorithmHeader_nullContext
[06/09/18 01:59:48:802 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 JwtContext is null
[06/09/18 01:59:48:802 BST] 00000012 id=00000000 SystemOut                                                    O Exiting test: testGetAlgorithmHeader_nullContext
[06/09/18 01:59:48:804 BST] 00000012 id=00000000 SystemOut                                                    O Entering test: testGetAlgorithmHeader_missingJsonWebStructures
[06/09/18 01:59:48:804 BST] 00000012 id=00000000 com.ibm.ws.security.common.random.RandomUtils                3 Chose random selection: [null]
[06/09/18 01:59:48:804 BST] 00000012 id=00000000 SystemOut                                                    O Chose list: null
[06/09/18 01:59:48:829 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Failed to obtain JWT header
[06/09/18 01:59:48:830 BST] 00000012 id=00000000 SystemOut                                                    O Exiting test: testGetAlgorithmHeader_missingJsonWebStructures
[06/09/18 01:59:48:831 BST] 00000012 id=00000000 SystemOut                                                    O Entering test: testGetAlgorithmHeader_validAlgorithmHeader
[06/09/18 01:59:48:832 BST] 00000012 id=00000000 com.ibm.ws.security.common.random.RandomUtils                3 Chose random selection: [RS256]
[06/09/18 01:59:48:836 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 JsonWebStructure class: org.jose4j.jws.JsonWebSignature data:JsonWebSignature{"alg":"RS256"}
[06/09/18 01:59:48:836 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 JsonWebSignature alg: RS256 3rd:'null'
[06/09/18 01:59:48:836 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 JWT is signed with algorithm:  
                                                                                                               RS256
[06/09/18 01:59:48:836 BST] 00000012 id=00000000 SystemOut                                                    O Exiting test: testGetAlgorithmHeader_validAlgorithmHeader
[06/09/18 01:59:48:838 BST] 00000012 id=00000000 SystemOut                                                    O Entering test: testValidateAlgorithm_nullArgs
[06/09/18 01:59:48:839 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 No required signature algorithm was specified
[06/09/18 01:59:48:839 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 No required signature algorithm was specified
[06/09/18 01:59:48:839 BST] 00000012 id=00000000 com.ibm.ws.security.common.random.RandomUtils                3 Chose random selection: [HS256]
[06/09/18 01:59:48:839 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 JwtContext is null
[06/09/18 01:59:48:839 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 Signature algorithm was not found in the JWT
[06/09/18 01:59:48:839 BST] 00000012 id=00000000 SystemOut                                                    O Exiting test: testValidateAlgorithm_nullArgs
[06/09/18 01:59:48:841 BST] 00000012 id=00000000 SystemOut                                                    O Entering test: testValidateAlgorithm_algMismatch
[06/09/18 01:59:48:841 BST] 00000012 id=00000000 com.ibm.ws.security.common.random.RandomUtils                3 Chose random selection: [RS256]
[06/09/18 01:59:48:859 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 JsonWebStructure class: org.jose4j.jwx.JsonWebStructure$$EnhancerByCGLIB$$a8760504 data:jsonWebStructure
[06/09/18 01:59:48:859 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 JWT is signed with algorithm:  
                                                                                                               SomeOtherAlgorithm
[06/09/18 01:59:48:859 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 JWT is signed with algorithm:  
                                                                                                               SomeOtherAlgorithm
[06/09/18 01:59:48:859 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 JWT is required to be signed with algorithm:  
                                                                                                               RS256
[06/09/18 01:59:48:860 BST] 00000012 id=00000000 SystemOut                                                    O Exiting test: testValidateAlgorithm_algMismatch
[06/09/18 01:59:48:862 BST] 00000012 id=00000000 SystemOut                                                    O Entering test: testValidateAlgorithm_algMatch
[06/09/18 01:59:48:863 BST] 00000012 id=00000000 com.ibm.ws.security.common.random.RandomUtils                3 Chose random selection: [RS256]
[06/09/18 01:59:48:863 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 JsonWebStructure class: org.jose4j.jwx.JsonWebStructure$$EnhancerByCGLIB$$a8760504 data:jsonWebStructure
[06/09/18 01:59:48:864 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 JWT is signed with algorithm:  
                                                                                                               RS256
[06/09/18 01:59:48:864 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 JWT is signed with algorithm:  
                                                                                                               RS256
[06/09/18 01:59:48:864 BST] 00000012 id=00000000 com.ibm.ws.security.jwt.internal.ConsumerUtil                3 JWT is required to be signed with algorithm:  
                                                                                                               RS256
[06/09/18 01:59:48:864 BST] 00000012 id=00000000 SystemOut                                                    O Exiting test: testValidateAlgorithm_algMatch